builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1463463674.68 results: success (0) buildid: 20160516220137 builduid: b339a9849e3148e5908457ea97e60907 revision: 4c709f7a03350ad5e36d0d726c8f12106ed2049d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.680825) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.681339) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.681680) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.728503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.728854) ========= 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-1463463327.660310-2054429155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 22:41:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-05-16 22:41:15 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.900890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.901341) ========= 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-1463463327.660310-2054429155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.953126) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:14.953830) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c709f7a03350ad5e36d0d726c8f12106ed2049d --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 4c709f7a03350ad5e36d0d726c8f12106ed2049d --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-1463463327.660310-2054429155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 22:41:15,853 truncating revision to first 12 chars 2016-05-16 22:41:15,854 Setting DEBUG logging. 2016-05-16 22:41:15,854 attempt 1/10 2016-05-16 22:41:15,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c709f7a0335?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 22:41:16,214 unpacking tar archive at: fx-team-4c709f7a0335/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.620517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.620956) ========= script_repo_revision: 4c709f7a03350ad5e36d0d726c8f12106ed2049d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.621400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.621728) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 22:41:15.631631) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-16 22:41:15.631974) ========= /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-1463463327.660310-2054429155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:41:16 INFO - MultiFileLogger online at 20160516 22:41:16 in /builds/slave/test 22:41:16 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 22:41:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:41:16 INFO - {'append_to_log': False, 22:41:16 INFO - 'base_work_dir': '/builds/slave/test', 22:41:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:41:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:41:16 INFO - 'branch': 'Fx-Team-Non-PGO', 22:41:16 INFO - 'buildbot_json_path': 'buildprops.json', 22:41:16 INFO - 'config_files': ('talos/linux_config.py',), 22:41:16 INFO - 'default_actions': ('clobber', 22:41:16 INFO - 'read-buildbot-config', 22:41:16 INFO - 'download-and-extract', 22:41:16 INFO - 'populate-webroot', 22:41:16 INFO - 'create-virtualenv', 22:41:16 INFO - 'install', 22:41:16 INFO - 'run-tests'), 22:41:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:41:16 INFO - 'download_minidump_stackwalk': True, 22:41:16 INFO - 'download_symbols': 'ondemand', 22:41:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:41:16 INFO - 'tooltool.py': '/tools/tooltool.py', 22:41:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:41:16 INFO - '/tools/misc-python/virtualenv.py')}, 22:41:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:41:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:41:16 INFO - 'installer_path': 'installer.exe', 22:41:16 INFO - 'log_level': 'info', 22:41:16 INFO - 'log_name': 'talos', 22:41:16 INFO - 'log_to_console': True, 22:41:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:41:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:41:16 INFO - 'opt_config_files': (), 22:41:16 INFO - 'pip_index': False, 22:41:16 INFO - 'sps_profile': False, 22:41:16 INFO - 'sps_profile_interval': 0, 22:41:16 INFO - 'suite': 'dromaeojs-e10s', 22:41:16 INFO - 'system_bits': '32', 22:41:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:41:16 INFO - 'title': 'talos-linux64-ix-025', 22:41:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:41:16 INFO - 'use_talos_json': True, 22:41:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:41:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:41:16 INFO - 'work_dir': 'build'} 22:41:16 INFO - ##### 22:41:16 INFO - ##### Running clobber step. 22:41:16 INFO - ##### 22:41:16 INFO - Running pre-action listener: _resource_record_pre_action 22:41:16 INFO - Running main action method: clobber 22:41:16 INFO - rmtree: /builds/slave/test/build 22:41:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:41:17 INFO - Running post-action listener: _resource_record_post_action 22:41:17 INFO - ##### 22:41:17 INFO - ##### Finished clobber step (success) 22:41:17 INFO - ##### 22:41:17 INFO - ##### 22:41:17 INFO - ##### Running read-buildbot-config step. 22:41:17 INFO - ##### 22:41:17 INFO - Running pre-action listener: _resource_record_pre_action 22:41:17 INFO - Running main action method: read_buildbot_config 22:41:17 INFO - Using buildbot properties: 22:41:17 INFO - { 22:41:17 INFO - "project": "", 22:41:17 INFO - "product": "firefox", 22:41:17 INFO - "script_repo_revision": "production", 22:41:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:41:17 INFO - "repository": "", 22:41:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:41:17 INFO - "buildid": "20160516220137", 22:41:17 INFO - "pgo_build": "False", 22:41:17 INFO - "basedir": "/builds/slave/test", 22:41:17 INFO - "buildnumber": 1271, 22:41:17 INFO - "slavename": "talos-linux64-ix-025", 22:41:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:41:17 INFO - "platform": "ubuntu64_hw", 22:41:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:41:17 INFO - "branch": "fx-team", 22:41:17 INFO - "repo_path": "integration/fx-team", 22:41:17 INFO - "revision": "4c709f7a03350ad5e36d0d726c8f12106ed2049d", 22:41:17 INFO - "stage_platform": "linux64", 22:41:17 INFO - "builduid": "b339a9849e3148e5908457ea97e60907", 22:41:17 INFO - "slavebuilddir": "test" 22:41:17 INFO - } 22:41:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:41:17 INFO - Running post-action listener: _resource_record_post_action 22:41:17 INFO - ##### 22:41:17 INFO - ##### Finished read-buildbot-config step (success) 22:41:17 INFO - ##### 22:41:17 INFO - ##### 22:41:17 INFO - ##### Running download-and-extract step. 22:41:17 INFO - ##### 22:41:17 INFO - Running pre-action listener: _resource_record_pre_action 22:41:17 INFO - Running main action method: download_and_extract 22:41:17 INFO - mkdir: /builds/slave/test/build/tests 22:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:17 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:41:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:41:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:41:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:22 INFO - Downloaded 1361 bytes. 22:41:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:41:22 INFO - Using the following test package requirements: 22:41:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:41:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:41:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'jsshell-linux-x86_64.zip'], 22:41:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:41:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:41:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:41:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:41:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:41:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:22 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:41:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:41:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:24 INFO - Downloaded 22448136 bytes. 22:41:24 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'] 22:41:24 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 22:41:25 INFO - Return code: 0 22:41:25 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 22:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:25 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:41:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:41:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:32 INFO - Downloaded 22448136 bytes. 22:41:32 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'] 22:41:32 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 22:41:33 INFO - Return code: 0 22:41:33 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')]} 22:41:33 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:41:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:34 INFO - Downloaded 10840194 bytes. 22:41:34 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'] 22:41:34 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 22:41:34 INFO - Return code: 0 22:41:34 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')]} 22:41:34 INFO - https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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 22:41:36 INFO - Downloaded 54767525 bytes. 22:41:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:41:36 INFO - mkdir: /builds/slave/test/properties 22:41:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:41:36 INFO - Writing to file /builds/slave/test/properties/build_url 22:41:36 INFO - Contents: 22:41:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:41:36 INFO - Running post-action listener: _resource_record_post_action 22:41:36 INFO - Running post-action listener: set_extra_try_arguments 22:41:36 INFO - ##### 22:41:36 INFO - ##### Finished download-and-extract step (success) 22:41:36 INFO - ##### 22:41:36 INFO - ##### 22:41:36 INFO - ##### Running populate-webroot step. 22:41:36 INFO - ##### 22:41:36 INFO - Running pre-action listener: _resource_record_pre_action 22:41:36 INFO - Running main action method: populate_webroot 22:41:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:41:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:41:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:41:36 INFO - '--tppagecycles', 22:41:36 INFO - '7'], 22:41:36 INFO - 'tests': ['tsvgm']}}, 22:41:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:41:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:41:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:41:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:41:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:36 INFO - 'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:36 INFO - 'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['damp', 'tps']}, 22:41:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:36 INFO - 'tests': ['damp', 'tps']}, 22:41:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['dromaeo_dom']}, 22:41:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:41:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['a11yr', 22:41:36 INFO - 'ts_paint', 22:41:36 INFO - 'tpaint', 22:41:36 INFO - 'sessionrestore', 22:41:36 INFO - 'sessionrestore_no_auto_restore', 22:41:36 INFO - 'tabpaint']}, 22:41:36 INFO - 'other-e10s': {'tests': ['a11yr', 22:41:36 INFO - 'ts_paint', 22:41:36 INFO - 'tpaint', 22:41:36 INFO - 'sessionrestore', 22:41:36 INFO - 'sessionrestore_no_auto_restore', 22:41:36 INFO - 'tabpaint']}, 22:41:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:41:36 INFO - 'ts_paint', 22:41:36 INFO - 'tpaint', 22:41:36 INFO - 'sessionrestore', 22:41:36 INFO - 'sessionrestore_no_auto_restore', 22:41:36 INFO - 'tabpaint']}, 22:41:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:41:36 INFO - 'ts_paint', 22:41:36 INFO - 'tpaint', 22:41:36 INFO - 'sessionrestore', 22:41:36 INFO - 'sessionrestore_no_auto_restore', 22:41:36 INFO - 'tabpaint']}, 22:41:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['a11yr', 22:41:36 INFO - 'ts_paint', 22:41:36 INFO - 'tpaint', 22:41:36 INFO - 'sessionrestore', 22:41:36 INFO - 'sessionrestore_no_auto_restore', 22:41:36 INFO - 'tabpaint']}, 22:41:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['a11yr', 22:41:36 INFO - 'ts_paint', 22:41:36 INFO - 'tpaint', 22:41:36 INFO - 'sessionrestore', 22:41:36 INFO - 'sessionrestore_no_auto_restore', 22:41:36 INFO - 'tabpaint']}, 22:41:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['tsvgx', 22:41:36 INFO - 'tsvgr_opacity', 22:41:36 INFO - 'tart', 22:41:36 INFO - 'tscrollx', 22:41:36 INFO - 'cart']}, 22:41:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:41:36 INFO - 'tsvgr_opacity', 22:41:36 INFO - 'tart', 22:41:36 INFO - 'tscrollx', 22:41:36 INFO - 'cart']}, 22:41:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:36 INFO - 'talos_options': ['--disable-e10s'], 22:41:36 INFO - 'tests': ['tp5o']}, 22:41:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:36 INFO - 'tests': ['tp5o']}, 22:41:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:36 INFO - 'talos_options': ['--disable-e10s', 22:41:36 INFO - '--xperf_path', 22:41:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:36 INFO - 'tests': ['tp5n']}, 22:41:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:36 INFO - 'talos_options': ['--xperf_path', 22:41:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:36 INFO - 'tests': ['tp5n']}}, 22:41:36 INFO - 'talos.zip': {'path': '', 22:41:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:41:36 INFO - Running post-action listener: _resource_record_post_action 22:41:36 INFO - ##### 22:41:36 INFO - ##### Finished populate-webroot step (success) 22:41:36 INFO - ##### 22:41:36 INFO - ##### 22:41:36 INFO - ##### Running create-virtualenv step. 22:41:36 INFO - ##### 22:41:36 INFO - Running pre-action listener: _resource_record_pre_action 22:41:36 INFO - Running main action method: create_virtualenv 22:41:36 INFO - Creating virtualenv /builds/slave/test/build/venv 22:41:36 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 22:41:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:41:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:41:37 INFO - Using real prefix '/usr' 22:41:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:41:37 INFO - Installing distribute.............................................................................................................................................................................................done. 22:41:39 INFO - Installing pip.................done. 22:41:39 INFO - Return code: 0 22:41:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:39 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 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:39 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 22:41:39 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 22:41:39 INFO - Using env: {'DISPLAY': ':0', 22:41:39 INFO - 'HOME': '/home/cltbld', 22:41:39 INFO - 'LANG': 'en_US.UTF-8', 22:41:39 INFO - 'LANGUAGE': 'en_US:en', 22:41:39 INFO - 'LOGNAME': 'cltbld', 22:41:39 INFO - 'MAIL': '/var/mail/cltbld', 22:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:39 INFO - 'MOZ_NO_REMOTE': '1', 22:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:39 INFO - 'NO_EM_RESTART': '1', 22:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:39 INFO - 'PWD': '/builds/slave/test', 22:41:39 INFO - 'SHELL': '/bin/bash', 22:41:39 INFO - 'SHLVL': '1', 22:41:39 INFO - 'TERM': 'linux', 22:41:39 INFO - 'TMOUT': '86400', 22:41:39 INFO - 'USER': 'cltbld', 22:41:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:39 INFO - '_': '/tools/buildbot/bin/python'} 22:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:39 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 22:41:39 INFO - Cleaning up... 22:41:39 INFO - Return code: 0 22:41:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:39 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 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:39 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 22:41:39 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 22:41:39 INFO - Using env: {'DISPLAY': ':0', 22:41:39 INFO - 'HOME': '/home/cltbld', 22:41:39 INFO - 'LANG': 'en_US.UTF-8', 22:41:39 INFO - 'LANGUAGE': 'en_US:en', 22:41:39 INFO - 'LOGNAME': 'cltbld', 22:41:39 INFO - 'MAIL': '/var/mail/cltbld', 22:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:39 INFO - 'MOZ_NO_REMOTE': '1', 22:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:39 INFO - 'NO_EM_RESTART': '1', 22:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:39 INFO - 'PWD': '/builds/slave/test', 22:41:39 INFO - 'SHELL': '/bin/bash', 22:41:39 INFO - 'SHLVL': '1', 22:41:39 INFO - 'TERM': 'linux', 22:41:39 INFO - 'TMOUT': '86400', 22:41:39 INFO - 'USER': 'cltbld', 22:41:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:39 INFO - '_': '/tools/buildbot/bin/python'} 22:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:39 INFO - Downloading/unpacking psutil>=3.1.1 22:41:39 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 22:41:39 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 22:41:39 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 22:41:39 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 22:41:39 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 22:41:39 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 22:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:41:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:41 INFO - Installing collected packages: psutil 22:41:41 INFO - Running setup.py install for psutil 22:41:41 INFO - building 'psutil._psutil_linux' extension 22:41:41 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 22:41:42 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 22:41:42 INFO - building 'psutil._psutil_posix' extension 22:41:42 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 22:41:42 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 22:41:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:42 INFO - Successfully installed psutil 22:41:42 INFO - Cleaning up... 22:41:42 INFO - Return code: 0 22:41:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:42 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 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:42 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 22:41:42 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 22:41:42 INFO - Using env: {'DISPLAY': ':0', 22:41:42 INFO - 'HOME': '/home/cltbld', 22:41:42 INFO - 'LANG': 'en_US.UTF-8', 22:41:42 INFO - 'LANGUAGE': 'en_US:en', 22:41:42 INFO - 'LOGNAME': 'cltbld', 22:41:42 INFO - 'MAIL': '/var/mail/cltbld', 22:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:42 INFO - 'MOZ_NO_REMOTE': '1', 22:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:42 INFO - 'NO_EM_RESTART': '1', 22:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:42 INFO - 'PWD': '/builds/slave/test', 22:41:42 INFO - 'SHELL': '/bin/bash', 22:41:42 INFO - 'SHLVL': '1', 22:41:42 INFO - 'TERM': 'linux', 22:41:42 INFO - 'TMOUT': '86400', 22:41:42 INFO - 'USER': 'cltbld', 22:41:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:42 INFO - '_': '/tools/buildbot/bin/python'} 22:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:41:42 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 22:41:42 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 22:41:42 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 22:41:42 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 22:41:42 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 22:41:42 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 22:41:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:41:44 INFO - Installing collected packages: mozsystemmonitor 22:41:44 INFO - Running setup.py install for mozsystemmonitor 22:41:44 INFO - Successfully installed mozsystemmonitor 22:41:44 INFO - Cleaning up... 22:41:44 INFO - Return code: 0 22:41:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:41:44 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')]} 22:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:44 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')]} 22:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:44 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 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:44 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 22:41:44 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 22:41:44 INFO - Using env: {'DISPLAY': ':0', 22:41:44 INFO - 'HOME': '/home/cltbld', 22:41:44 INFO - 'LANG': 'en_US.UTF-8', 22:41:44 INFO - 'LANGUAGE': 'en_US:en', 22:41:44 INFO - 'LOGNAME': 'cltbld', 22:41:44 INFO - 'MAIL': '/var/mail/cltbld', 22:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:44 INFO - 'MOZ_NO_REMOTE': '1', 22:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:44 INFO - 'NO_EM_RESTART': '1', 22:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:44 INFO - 'PWD': '/builds/slave/test', 22:41:44 INFO - 'SHELL': '/bin/bash', 22:41:44 INFO - 'SHLVL': '1', 22:41:44 INFO - 'TERM': 'linux', 22:41:44 INFO - 'TMOUT': '86400', 22:41:44 INFO - 'USER': 'cltbld', 22:41:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:44 INFO - '_': '/tools/buildbot/bin/python'} 22:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:44 INFO - Downloading/unpacking blobuploader==1.2.4 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:46 INFO - Downloading blobuploader-1.2.4.tar.gz 22:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:41:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:41:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:41:47 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 22:41:47 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 22:41:47 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 22:41:47 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 22:41:47 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 22:41:47 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 22:41:47 INFO - Downloading docopt-0.6.1.tar.gz 22:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:41:47 INFO - Installing collected packages: blobuploader, requests, docopt 22:41:47 INFO - Running setup.py install for blobuploader 22:41:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:41:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:41:47 INFO - Running setup.py install for requests 22:41:48 INFO - Running setup.py install for docopt 22:41:48 INFO - Successfully installed blobuploader requests docopt 22:41:48 INFO - Cleaning up... 22:41:48 INFO - Return code: 0 22:41:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:48 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 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:48 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 22:41:48 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 22:41:48 INFO - Using env: {'DISPLAY': ':0', 22:41:48 INFO - 'HOME': '/home/cltbld', 22:41:48 INFO - 'LANG': 'en_US.UTF-8', 22:41:48 INFO - 'LANGUAGE': 'en_US:en', 22:41:48 INFO - 'LOGNAME': 'cltbld', 22:41:48 INFO - 'MAIL': '/var/mail/cltbld', 22:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:48 INFO - 'MOZ_NO_REMOTE': '1', 22:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:48 INFO - 'NO_EM_RESTART': '1', 22:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:48 INFO - 'PWD': '/builds/slave/test', 22:41:48 INFO - 'SHELL': '/bin/bash', 22:41:48 INFO - 'SHLVL': '1', 22:41:48 INFO - 'TERM': 'linux', 22:41:48 INFO - 'TMOUT': '86400', 22:41:48 INFO - 'USER': 'cltbld', 22:41:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:48 INFO - '_': '/tools/buildbot/bin/python'} 22:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:48 INFO - Running setup.py (path:/tmp/pip-jGei2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:48 INFO - Running setup.py (path:/tmp/pip-L4TweX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:48 INFO - Running setup.py (path:/tmp/pip-gc2rNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:48 INFO - Running setup.py (path:/tmp/pip-gbI9rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:48 INFO - Running setup.py (path:/tmp/pip-4GH2cX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:48 INFO - Running setup.py (path:/tmp/pip-sbreZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:48 INFO - Running setup.py (path:/tmp/pip-bVYCbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:48 INFO - Running setup.py (path:/tmp/pip-lskZqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:48 INFO - Running setup.py (path:/tmp/pip-tCzFM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:49 INFO - Running setup.py (path:/tmp/pip-2kqlXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:49 INFO - Running setup.py (path:/tmp/pip-o1Krs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:49 INFO - Running setup.py (path:/tmp/pip-3WMIPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:49 INFO - Running setup.py (path:/tmp/pip-_ROauT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:49 INFO - Running setup.py (path:/tmp/pip-tTUWIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:49 INFO - Running setup.py (path:/tmp/pip-GOpC8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:49 INFO - Running setup.py (path:/tmp/pip-A9Zbwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:49 INFO - Running setup.py (path:/tmp/pip-3fJ0If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:41:49 INFO - Running setup.py install for manifestparser 22:41:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:41:49 INFO - Running setup.py install for mozcrash 22:41:49 INFO - Running setup.py install for mozdebug 22:41:49 INFO - Running setup.py install for mozdevice 22:41:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Running setup.py install for mozfile 22:41:50 INFO - Running setup.py install for mozhttpd 22:41:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Running setup.py install for mozinfo 22:41:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Running setup.py install for mozInstall 22:41:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Running setup.py install for mozleak 22:41:50 INFO - Running setup.py install for mozlog 22:41:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Running setup.py install for moznetwork 22:41:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Running setup.py install for mozprocess 22:41:50 INFO - Running setup.py install for mozprofile 22:41:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:41:50 INFO - Running setup.py install for mozrunner 22:41:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:41:51 INFO - Running setup.py install for mozscreenshot 22:41:51 INFO - Running setup.py install for moztest 22:41:51 INFO - Running setup.py install for mozversion 22:41:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:41:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:41:51 INFO - Cleaning up... 22:41:51 INFO - Return code: 0 22:41:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:51 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 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:51 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 22:41:51 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 22:41:51 INFO - Using env: {'DISPLAY': ':0', 22:41:51 INFO - 'HOME': '/home/cltbld', 22:41:51 INFO - 'LANG': 'en_US.UTF-8', 22:41:51 INFO - 'LANGUAGE': 'en_US:en', 22:41:51 INFO - 'LOGNAME': 'cltbld', 22:41:51 INFO - 'MAIL': '/var/mail/cltbld', 22:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:51 INFO - 'MOZ_NO_REMOTE': '1', 22:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:51 INFO - 'NO_EM_RESTART': '1', 22:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:51 INFO - 'PWD': '/builds/slave/test', 22:41:51 INFO - 'SHELL': '/bin/bash', 22:41:51 INFO - 'SHLVL': '1', 22:41:51 INFO - 'TERM': 'linux', 22:41:51 INFO - 'TMOUT': '86400', 22:41:51 INFO - 'USER': 'cltbld', 22:41:51 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:51 INFO - '_': '/tools/buildbot/bin/python'} 22:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:41:51 INFO - Running setup.py (path:/tmp/pip-T3p5FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:41:51 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)) 22:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:41:51 INFO - Running setup.py (path:/tmp/pip-PmzmVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:41:51 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)) 22:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:41:51 INFO - Running setup.py (path:/tmp/pip-_dpZtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:41:51 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)) 22:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:41:51 INFO - Running setup.py (path:/tmp/pip-atah6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:41:51 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)) 22:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:41:51 INFO - Running setup.py (path:/tmp/pip-YwAtHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:41:52 INFO - Running setup.py (path:/tmp/pip-TavDCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:41:52 INFO - Running setup.py (path:/tmp/pip-5sw2sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:41:52 INFO - Running setup.py (path:/tmp/pip-08Tljw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:41:52 INFO - Running setup.py (path:/tmp/pip-dUKHm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:41:52 INFO - Running setup.py (path:/tmp/pip-iZjuvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:41:52 INFO - Running setup.py (path:/tmp/pip-u_8s3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:41:52 INFO - Running setup.py (path:/tmp/pip-O83pmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:41:52 INFO - Running setup.py (path:/tmp/pip-Ck7_mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:41:52 INFO - Running setup.py (path:/tmp/pip-OgLR72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:52 INFO - Running setup.py (path:/tmp/pip-1tObw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:41:52 INFO - Running setup.py (path:/tmp/pip-Ef4vSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:41:52 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)) 22:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:41:52 INFO - Running setup.py (path:/tmp/pip-dRZXZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:41:52 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)) 22:41:52 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)) 22:41:52 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)) 22:41:52 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)) 22:41:52 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)) 22:41:52 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)) 22:41:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:54 INFO - Downloading blessings-1.6.tar.gz 22:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:41:54 INFO - Installing collected packages: blessings 22:41:54 INFO - Running setup.py install for blessings 22:41:54 INFO - Successfully installed blessings 22:41:54 INFO - Cleaning up... 22:41:55 INFO - Return code: 0 22:41:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:41:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:41:55 INFO - Reading from file tmpfile_stdout 22:41:55 INFO - Current package versions: 22:41:55 INFO - argparse == 1.2.1 22:41:55 INFO - blessings == 1.6 22:41:55 INFO - blobuploader == 1.2.4 22:41:55 INFO - docopt == 0.6.1 22:41:55 INFO - manifestparser == 1.1 22:41:55 INFO - mozInstall == 1.12 22:41:55 INFO - mozcrash == 0.17 22:41:55 INFO - mozdebug == 0.1 22:41:55 INFO - mozdevice == 0.48 22:41:55 INFO - mozfile == 1.2 22:41:55 INFO - mozhttpd == 0.7 22:41:55 INFO - mozinfo == 0.9 22:41:55 INFO - mozleak == 0.1 22:41:55 INFO - mozlog == 3.2 22:41:55 INFO - moznetwork == 0.27 22:41:55 INFO - mozprocess == 0.22 22:41:55 INFO - mozprofile == 0.28 22:41:55 INFO - mozrunner == 6.11 22:41:55 INFO - mozscreenshot == 0.1 22:41:55 INFO - mozsystemmonitor == 0.3 22:41:55 INFO - moztest == 0.7 22:41:55 INFO - mozversion == 1.4 22:41:55 INFO - psutil == 3.1.1 22:41:55 INFO - requests == 1.2.3 22:41:55 INFO - wsgiref == 0.1.2 22:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:55 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 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:55 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 22:41:55 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 22:41:55 INFO - Using env: {'DISPLAY': ':0', 22:41:55 INFO - 'HOME': '/home/cltbld', 22:41:55 INFO - 'LANG': 'en_US.UTF-8', 22:41:55 INFO - 'LANGUAGE': 'en_US:en', 22:41:55 INFO - 'LOGNAME': 'cltbld', 22:41:55 INFO - 'MAIL': '/var/mail/cltbld', 22:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:55 INFO - 'MOZ_NO_REMOTE': '1', 22:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:55 INFO - 'NO_EM_RESTART': '1', 22:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:55 INFO - 'PWD': '/builds/slave/test', 22:41:55 INFO - 'SHELL': '/bin/bash', 22:41:55 INFO - 'SHLVL': '1', 22:41:55 INFO - 'TERM': 'linux', 22:41:55 INFO - 'TMOUT': '86400', 22:41:55 INFO - 'USER': 'cltbld', 22:41:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:55 INFO - '_': '/tools/buildbot/bin/python'} 22:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 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)) 22:41:55 INFO - Cleaning up... 22:41:55 INFO - Return code: 0 22:41:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:41:55 INFO - Using env: {'DISPLAY': ':0', 22:41:55 INFO - 'HOME': '/home/cltbld', 22:41:55 INFO - 'LANG': 'en_US.UTF-8', 22:41:55 INFO - 'LANGUAGE': 'en_US:en', 22:41:55 INFO - 'LOGNAME': 'cltbld', 22:41:55 INFO - 'MAIL': '/var/mail/cltbld', 22:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:55 INFO - 'MOZ_NO_REMOTE': '1', 22:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:55 INFO - 'NO_EM_RESTART': '1', 22:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:55 INFO - 'PWD': '/builds/slave/test', 22:41:55 INFO - 'SHELL': '/bin/bash', 22:41:55 INFO - 'SHLVL': '1', 22:41:55 INFO - 'TERM': 'linux', 22:41:55 INFO - 'TMOUT': '86400', 22:41:55 INFO - 'USER': 'cltbld', 22:41:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:55 INFO - '_': '/tools/buildbot/bin/python'} 22:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:55 INFO - Downloading/unpacking jsonschema 22:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:41:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:41:57 INFO - Downloading/unpacking functools32 (from jsonschema) 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:57 INFO - Downloading functools32-3.2.3-2.tar.gz 22:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:41:57 INFO - warning: no files found matching '*.txt' 22:41:57 INFO - no previously-included directories found matching 'build' 22:41:57 INFO - no previously-included directories found matching 'dist' 22:41:57 INFO - no previously-included directories found matching '.git*' 22:41:57 INFO - Installing collected packages: jsonschema, functools32 22:41:57 INFO - Running setup.py install for functools32 22:41:57 INFO - warning: no files found matching '*.txt' 22:41:57 INFO - no previously-included directories found matching 'build' 22:41:57 INFO - no previously-included directories found matching 'dist' 22:41:57 INFO - no previously-included directories found matching '.git*' 22:41:57 INFO - Successfully installed jsonschema functools32 22:41:57 INFO - Cleaning up... 22:41:58 INFO - Return code: 0 22:41:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:58 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 0x7f6b7b422f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18cb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, '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-1463463327.660310-2054429155', '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 22:41:58 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 22:41:58 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 22:41:58 INFO - Using env: {'DISPLAY': ':0', 22:41:58 INFO - 'HOME': '/home/cltbld', 22:41:58 INFO - 'LANG': 'en_US.UTF-8', 22:41:58 INFO - 'LANGUAGE': 'en_US:en', 22:41:58 INFO - 'LOGNAME': 'cltbld', 22:41:58 INFO - 'MAIL': '/var/mail/cltbld', 22:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:58 INFO - 'MOZ_NO_REMOTE': '1', 22:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:58 INFO - 'NO_EM_RESTART': '1', 22:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:41:58 INFO - 'PWD': '/builds/slave/test', 22:41:58 INFO - 'SHELL': '/bin/bash', 22:41:58 INFO - 'SHLVL': '1', 22:41:58 INFO - 'TERM': 'linux', 22:41:58 INFO - 'TMOUT': '86400', 22:41:58 INFO - 'USER': 'cltbld', 22:41:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:58 INFO - '_': '/tools/buildbot/bin/python'} 22:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:58 INFO - Downloading/unpacking flake8 22:41:58 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 22:41:58 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 22:41:58 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 22:41:58 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 22:41:58 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 22:41:58 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 22:42:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:42:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:42:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:42:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:00 INFO - no previously-included directories found matching 'docs/_build' 22:42:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:42:00 INFO - Running setup.py install for pep8 22:42:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:01 INFO - no previously-included directories found matching 'docs/_build' 22:42:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:42:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:42:01 INFO - Cleaning up... 22:42:01 INFO - Return code: 0 22:42:01 INFO - Running post-action listener: _resource_record_post_action 22:42:01 INFO - Running post-action listener: _start_resource_monitoring 22:42:01 INFO - Starting resource monitoring. 22:42:01 INFO - ##### 22:42:01 INFO - ##### Finished create-virtualenv step (success) 22:42:01 INFO - ##### 22:42:01 INFO - ##### 22:42:01 INFO - ##### Running install step. 22:42:01 INFO - ##### 22:42:01 INFO - Running pre-action listener: _resource_record_pre_action 22:42:01 INFO - Running main action method: install 22:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:42:01 INFO - Reading from file tmpfile_stdout 22:42:01 INFO - Detecting whether we're running mozinstall >=1.0... 22:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:42:01 INFO - Reading from file tmpfile_stdout 22:42:01 INFO - Output received: 22:42:01 INFO - Usage: mozinstall [options] installer 22:42:01 INFO - Options: 22:42:01 INFO - -h, --help show this help message and exit 22:42:01 INFO - -d DEST, --destination=DEST 22:42:01 INFO - Directory to install application into. [default: 22:42:01 INFO - "/builds/slave/test"] 22:42:01 INFO - --app=APP Application being installed. [default: firefox] 22:42:01 INFO - mkdir: /builds/slave/test/build/application 22:42:01 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'] 22:42:01 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 22:42:17 INFO - Reading from file tmpfile_stdout 22:42:17 INFO - Output received: 22:42:17 INFO - /builds/slave/test/build/application/firefox/firefox 22:42:17 INFO - Running post-action listener: _resource_record_post_action 22:42:17 INFO - ##### 22:42:17 INFO - ##### Finished install step (success) 22:42:17 INFO - ##### 22:42:17 INFO - ##### 22:42:17 INFO - ##### Running run-tests step. 22:42:17 INFO - ##### 22:42:17 INFO - Running pre-action listener: _resource_record_pre_action 22:42:17 INFO - Running main action method: run_tests 22:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:42:17 INFO - Python 2.7.3 22:42:17 INFO - Return code: 0 22:42:17 INFO - grabbing minidump binary from tooltool 22:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:17 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 0x195a9c0>, '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 0x195b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x195bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:42:17 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 22:42:17 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 22:42:17 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 22:42:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:42:17 INFO - Return code: 0 22:42:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:42:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:42:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:42:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:42:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:42:18 INFO - Return code: 0 22:42:18 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/BG3sUWRRSSKOWa1BrDtnJg/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 22:42:18 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/BG3sUWRRSSKOWa1BrDtnJg/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 22:42:18 INFO - Using env: {'DISPLAY': ':0', 22:42:18 INFO - 'HOME': '/home/cltbld', 22:42:18 INFO - 'LANG': 'en_US.UTF-8', 22:42:18 INFO - 'LANGUAGE': 'en_US:en', 22:42:18 INFO - 'LOGNAME': 'cltbld', 22:42:18 INFO - 'MAIL': '/var/mail/cltbld', 22:42:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:42:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:18 INFO - 'MOZ_NO_REMOTE': '1', 22:42:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:18 INFO - 'NO_EM_RESTART': '1', 22:42:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:42:18 INFO - 'PWD': '/builds/slave/test', 22:42:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:42:18 INFO - 'SHELL': '/bin/bash', 22:42:18 INFO - 'SHLVL': '1', 22:42:18 INFO - 'TERM': 'linux', 22:42:18 INFO - 'TMOUT': '86400', 22:42:18 INFO - 'USER': 'cltbld', 22:42:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463463327.660310-2054429155', 22:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:18 INFO - '_': '/tools/buildbot/bin/python'} 22:42:18 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/BG3sUWRRSSKOWa1BrDtnJg/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 22:42:18 INFO - mozversion application_buildid: 20160516220137 22:42:18 INFO - mozversion application_changeset: 4c709f7a03350ad5e36d0d726c8f12106ed2049d 22:42:18 INFO - mozversion application_display_name: Nightly 22:42:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:42:18 INFO - mozversion application_name: Firefox 22:42:18 INFO - mozversion application_remotingname: firefox 22:42:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:42:18 INFO - mozversion application_vendor: Mozilla 22:42:18 INFO - mozversion application_version: 49.0a1 22:42:18 INFO - mozversion platform_buildid: 20160516220137 22:42:18 INFO - mozversion platform_changeset: 4c709f7a03350ad5e36d0d726c8f12106ed2049d 22:42:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:42:18 INFO - mozversion platform_version: 49.0a1 22:42:18 INFO - using testdate: 1463463738 22:42:18 INFO - actual date: 1463463738 22:42:18 INFO - starting webserver on 'localhost:60139' 22:42:18 INFO - SUITE-START | Running 2 tests 22:42:18 INFO - TEST-START | dromaeo_css 22:42:18 INFO - operating with platform_type : linux_ 22:42:18 INFO - Initialising browser for dromaeo_css test... 22:42:18 INFO - TEST-INFO | started process 20434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIeIB_Z/profile http://localhost:60139/getInfo.html) 22:42:22 INFO - PROCESS | 20434 | 22:42:22 INFO - PROCESS | 20434 | (process:20502): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:42:23 INFO - PROCESS | 20434 | __metrics Screen width/height:1600/1200 22:42:23 INFO - PROCESS | 20434 | colorDepth:24 22:42:23 INFO - PROCESS | 20434 | Browser inner width/height: 1024/697 22:42:23 INFO - PROCESS | 20434 | __metrics 22:42:24 ERROR - PROCESS | 20434 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 22:42:24 INFO - TEST-INFO | 20434: exit 0 22:42:24 INFO - Browser initialized. 22:42:24 INFO - Running cycle 1/1 for dromaeo_css test... 22:42:24 INFO - TEST-INFO | started process 20553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIeIB_Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:26 INFO - PROCESS | 20553 | 22:42:26 INFO - PROCESS | 20553 | (process:20612): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:42:36 INFO - PROCESS | 20553 | RSS: Main: 164655104 22:42:36 INFO - PROCESS | 20553 | 22:43:26 INFO - PROCESS | 20553 | 1463463806531 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] 22:45:38 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:60139/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60139/tests/dromaeo/cssquery-ext.html) 22:45:40 INFO - PROCESS | 20553 | RSS: Main: 167616512 22:45:40 INFO - PROCESS | 20553 | 22:48:42 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:60139/tests/dromaeo/cssquery-ext.html (next: http://localhost:60139/tests/dromaeo/cssquery-jquery.html) 22:48:42 INFO - PROCESS | 20553 | RSS: Main: 166903808 22:48:42 INFO - PROCESS | 20553 | 22:51:44 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:60139/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60139/tests/dromaeo/cssquery-mootools.html) 22:51:45 INFO - PROCESS | 20553 | RSS: Main: 167829504 22:51:45 INFO - PROCESS | 20553 | 22:54:47 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:60139/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60139/tests/dromaeo/cssquery-prototype.html) 22:54:47 INFO - PROCESS | 20553 | RSS: Main: 165539840 22:54:47 INFO - PROCESS | 20553 | 22:57:50 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:60139/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60139/tests/dromaeo/cssquery-yui.html) 22:57:51 INFO - PROCESS | 20553 | RSS: Main: 166752256 22:57:51 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | Cycle 1(1): loaded http://localhost:60139/tests/dromaeo/cssquery-yui.html (next: http://localhost:60139/tests/dromaeo/cssquery-dojo.html) 23:00:53 INFO - PROCESS | 20553 | RSS: Main: 168706048 23:00:53 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | __start_tp_report 23:00:53 INFO - PROCESS | 20553 | _x_x_mozilla_page_load 23:00:53 INFO - PROCESS | 20553 | _x_x_mozilla_page_load_details 23:00:53 INFO - PROCESS | 20553 | |i|pagename|runs| 23:00:53 INFO - PROCESS | 20553 | |0;dojo.html;2655.0309137164936;2682.2891933637584;2706.350475885788;2707.6750789905213;2712.4846279206963;4700.106979673864;4726.125666751654;4744.57298843104;4829.22732362822;4865.124277630025;4709.411323584552;4757.952420475803;4764.094821983821;4819.590334821544;4826;4378.6497080233585;4426.358178064179;4430.667699922503;4443.822247110128;4472.753998530079;4428.047969686517;4437.534058923815;4450.376947227391;4451.844185453509;4459.241928872083;4261.190373828963;4448.132614140244;4491.25894227452;4492.573205545468;4527.253003254459;4418.072204836988;4431.401760762288;4435.112977404499;4450.087732014929;4450.087732014961;4387.978060109711;4394.846180383671;4399.846005389828;4423.7566933818625;4438.223310920576;4637.814487420499;4645.605123564501;4684.648651351163;4684.836030738942;4700.811967521295;5159.097157997336;5194.168932970707;5197.610179236534;5201.895962080737;5215.608829337815;5106.846794596168;5130.563902068328;5137.049645815536;5174.844754657366;5191.922121168185;4688.109259240733;4692.906141877143;4696.8121275148615;4739.170645137122;4798.184308667535;5169.7932082717025;5175.689458632494;5179.171332586768;5182.119039763249;5239.44985776488;4932.605391568666;4948.480409556944;4977.104121258209;4996.025774973918;5006.4743201964;5063.949360506422;5119.87200319995;5163.277141200235;5192.169252919514;5210.322658054504;5124;5141.28022076902;5151.330327057459;5153.6907785532985;5216.26972223889;4984.127777638899;5132.769025393866;5139.254808052886;5151.974240128776;5169.715665638426;4059.6143366380147;4121.1345617420675;4129;4157.8960525987095;4183.205191013698;3624.9456258156147;3647.0882279430143;3665.248624032067;3675.761075530082;3711.9628803712158;4486.910261794746;4492.528284530143;4501.077279157765;4507.481639611421;4520.163769702615;5047.369078865142;5112.156494178494;5125.666831655931;5151.896962060738;5219.791208351699;4381.3208952612395;4383.693141480129;4387.166438376698;4395.428594282723;4434.933475997863;4635.95364046362;4670.369500117508;4670.859874203711;4671.18254305502;4711.599514041345;4773.856784296477;4794.161021821167;4847.854564363075;4853.684510506806;4875.07373599015;5154.690718556749;5159.226116082617;5168.250603662373;5183.844484665466;5217.634765566374;4776.785044672929;4863.878403039811;4874.073925954058;4874.439439464507;4881.243407271879;5079.492050794891;5090.516400941905;5107.770150343169;5116.411612664591;5151.356080489939;5195.220716892496;5198.012377648386;5199.090159222045;5232.659877107976;5260.921086183634;4911.852644420673;4913.385826771653;5021.096202683406;5036.194208926554;5042.974785126051;4979.800807967786;4988.501149884983;4990.326305948651;4999.350084488993;5055.9494405055475;4873.366462359871;4895.094407534618;4899.069176856386;4918.6065114791445;4994.550490455877;4952.8761780955765;5014;5037.370328708911;5057.595392368676;5103.362079740033;4792.448868380181;4974.676646017997;4975.10448119342;5004.624653150955;5039.420466646383 23:00:53 INFO - PROCESS | 20553 | |1;ext.html;546.1289243656369;604.926255895785;608.0726891490477;613.6502193749564;638.7891995641439;37089.81455092727;41492.17015659685;41565.79217103914;41652.58347416525;41679.79160104203;40806.7959660202;41553;41778.373324400156;41866.790666046625;41882;7917.683292668301;8051.114377418479;8055.879161812578;8064.516129032248;8074.6770129194765;7888;7960.920390796105;7975.322097621709;7977.122516523178;7994.480358776661;7898.5260884346835;7914.28771410573;7922.643481043367;7952.602369881512;7953.880691789628;7916.960415197887;7936.44444888858;7942.166072562384;7980.281774640282;8016.438849280553;7974.441789074767;8041.839163216761;8046.517208967481;8048.5170889746805;8075.152109028585;31182.22044448884;38578.228435431134;39136.21727565461;39142.21715565701;39362.40956385656;3076.769242306836;3189.378071276102;3190.1291076892508;3233.3856567252383;3295.0279667498144;28685.42629147426;28865.56701649456;29173.41653166925;30016.54975175374;30290.394192116255;3320.518524813913;3321.285923526429;3371.578552680915;3432.6910578047846;3510.912227194315;228216;230005;230738;231265;231874.8406257975;33855.83072084673;33885.49171762425;34086.65913340835;34815.65184348124;35029.12427189341;33703.662963370545;33783.66216337854;33931.66068339335;33993.83003084969;34004;13992.510262140777;14140.50508232207;14145;14151.080179788281;14170;11607.825882611767;11622.244554103956;11653.766924661459;11697.941510292394;11733.4719937603;8297.543635100006;8375.288100511403;8376.204260595234;8423.410361274651;8464;3321.5017747338093;3325.6840600143432;3328.367610154063;3361.46216605342;3364.596248450153;947.209080417845;973.9610415583297;1026.994865025685;1053.4206186597341;1085.2674444749762;27869.303267418072;28216.717832821818;28434.71565284362;28449.857750711115;28706;963.4893506441597;984.7931934293879;1001.6043662753171;1087.8694556653252;1106.8395082712962;15015.324310406058;15338.156401397808;15357.155356455502;15503.5348939532;15624.140672263135;300305;303642;304688;305966;307799;32587.837060814545;32945.341093178;33079.83460082732;33144.83427582846;33372.66627333744;1235.215638069814;1276.8531618863765;1284.2102107204003;1292.9870701293055;1325.6288239293012;26035.73964260333;27137;27882.581761274003;27944.16167514978;28223.57664634991;42433.57566424296;42507;42722;42861.78569107259;43055;267055;267188;268338;268557;268797;25508.362290942874;25512.744872551037;26000.34999124961;26025.349366265997;26066.73933260643;41553;41985.58014419817;42226.36660450034;42376.5762342385;43420;36146.09634759047;36443.63556364508;36701.81649091844;37113;37309.6269037317;36093.819530902176;36593.634063659025;36773.63226367702;37000.81499592485;37751.81124094362;35538.289234215685;35926.64073359233;36349;36385.27229455343;36640.81679591585;31802.52296215605;33425.66574334226;33436;33470.665293346756;33948.66051339455;24470.75529244756;25133;25279.494410112064;25370.574972378494;25550 23:00:53 INFO - PROCESS | 20553 | |2;jquery.html;377.4828484975582;378.9790324655406;385.9421086836974;395.2391646081293;403.1714826032502;15790.131542765143;17187.312507499715;17856.732149017775;17872.106394680264;17917.999999999985;17020.574485637866;17377.218025188864;17821.37625183119;17887.821121788777;17924.372646957327;5195.350581177362;5312.92030619541;5331.680099194061;5358.892822143554;5360.383555891083;3715.479832823407;5886.323072846613;6235.781747638811;6242.25092988842;6284;6029.758809647609;6206.224221972254;6225.782097626561;6264.718087686065;6269.279032911205;6129.264488261437;6175.135481032659;6185.474234690057;6188.762247550485;6211.565190436671;5322.760475778599;5445;5456.699881506515;5474.644148130359;5502.477264659851;20541.79458205429;21140.89429552858;21250.893745531328;21259;21489.892550537304;2044.3253726270295;2059.5159291462746;2069;2083.406229224679;2249.9437514062115;13412.329383530785;13690.863091369058;13815.240161791098;13901.79147312791;13926.860731392657;1683.3939781678587;1770;1835.2383760739276;1835.7613510243716;1919.7216403621537;70556.29443705549;72483.63758181228;72855;73283;73432.26567734308;9795.559199836025;9912.207023438108;9947.502624868872;9989.500524973722;10303.175745940307;13860.445582176802;14022.789658155136;14061.086029408056;14102.435902563782;14114.223717695626;7428.2571742825285;7629.160792312841;7800.45396822217;7850;7868.606569671493;7217.422606191492;7232;7386.704531818775;7403.703851845866;7429.665665045086;5636.943630563724;6293.622382657055;6293.748250070037;6413.551051426449;6528.183977002875;1692.9746053809204;1842.640685066399;1888.2824526679774;1908.8472922166193;1925.768907731053;868.6916144768643;876.1413814461863;902.9367944243971;904.968326108583;964.2382517810851;16444;16745.413910513318;16818;17069.40257090996;17290.567735806704;895.4537731983485;935.2517985611483;936.1574582875467;973.9172170365598;999.0558921818812;9775.853362199572;9827.606895724091;9935.503224838729;10025.548850301753;10214.693559193236;363844;367768;374683;380662;380954;65554.34445655483;66618.33381666218;68530.31469685338;68910;69627.3037269631;976.5166242709762;979.1725991536997;985.9704208873745;990.4008075114596;995.5669283861544;15356.462523811613;15372;15386.230688465308;15474.381024758884;15665.060096394252;26900.596491053042;33660.49509257314;34295.65704343024;34716.652833471344;35278.11804704903;41496.79251603843;42227.57772422236;43889.561104388544;44410.001549929686;44437.33343999907;7510.136334321623;7768.417368697484;7798.727044553413;7939.563324017235;8036.758897233092;11736.70658233551;11802.645920622395;11833.171677982802;11845.5854045108;11847.466863990969;10324;10424.895751042695;10599.311044782064;10655.14758819277;10778.407187604756;10223;10406.167506599302;10493.52779124926;10524.579016839241;10584.206184536037;10460.63387781424;10668.89331106679;10769.24615276923;10792.56829726802;10861.40262285582;7525.58609276495;7722.961385193263;7726;7779.611019448892;7833.529988200498;10465.319754216256;10639.627613033506;10680.465976701289;10784.352938823695;10848.620298289521 23:00:53 INFO - PROCESS | 20553 | |3;mootools.html;1489.501017159252;1510.237330148275;1689.9239534220958;1793.0944872839214;1822.5352535103539;6657.633830139341;7540.547567145975;7689.846203075935;8172.67309307627;8176.509409435431;7547.811304717385;7733.5359878407335;7862.174471680462;7880.645370958307;7945.880811787828;2168.728908886393;2225.554889022202;2229.1974889039934;2229.2420577003813;2231.509068005036;2177.4447515883426;2211.7124773779387;2235.2958817972367;2236.9888150559223;2240.7087078679747;2213.0373287619855;2216.4348091236793;2222.588821068108;2222.75549689534;2240.798328150466;2061.5258490547258;2066.917323307066;2076.3459510254297;2080.6462901306813;2083.2396175396025;2150.817180539656;2200.548887478079;2200.878951657658;2201.152556265833;2201.8128459081;7909.288164065204;7975.960120199362;7976.401769867225;8019;8041;4371.606555409997;4484.1928452878465;4488.05750792334;4489.842855500075;4502.369668246448;2798.2444739920106;2823.449427361665;2918.4454953558757;2922;2926.9707302926913;832.8792325112825;891.8394688955985;893.8391089603869;896.6771962093641;901.6393442622938;10763.300385474919;10918.563257469692;11016.944915275453;11028.779424411467;11043.061339786127;4171.290880550314;4301.913961720748;4380.67144964129;4410.889727756832;4414.911701765946;8602.225799677934;8658.826823463496;8665.956670216734;8716.520591367536;8752.47485150893;4755.429348478136;4762.928556071662;4762.9523704763205;4764.857054288377;4767.976160119247;3855.9614403856162;4254.170436764801;4386.166628340605;4421;4460.397846290774;3304.2069903223055;3327.9500807487907;3335.4830001349346;3386.4243078676686;3389.7288216942584;999.1017067571672;1014.9644762433279;1016.0398423489879;1017.353980222564;1035.5236591168148;801.9438639295194;839.131498898637;865.2774932930947;867.8568036273944;921.4056933277998;5135.922961155586;5233.476652334736;5253.44838791929;5277.261183434322;5289.20661900718;856.148132608059;875.3391189651772;892.2861710631469;908.1690253418049;960.8846938367441;3699.1491956850077;3736.7944763038295;3779.962200377961;3782.167923056923;3784.6593806557544;9025.097490251053;9246.352755307063;9292.814143717087;9388.577514011886;9497.952510237405;9255.074492550692;9265.073492650681;9268.72193834186;9314.813703725888;9331.72004839856;7157.6779044943105;7464.888026679604;7469.253074692488;7613.9238607614325;7667.386609071261;5314.8937021260135;5434.6525173541095;5551.694656793915;5635.436456354496;5705.543556515552;8392.748217553482;8513.74458766238;8540.27407670355;8788.384813063025;8802.33982451306;8644.913550864663;8761.737147885573;8763.868541971748;8789.736307910773;8885.42244754089;6048.848778780566;6642.667866606747;6677.399034086956;6791.151106111736;6826.965865170642;7574.583397913168;7687.692492300245;7789.298963093122;7856.646450909837;7863.449558530848;6833.59025397725;7026.718931242693;7070.893936590853;7086.50394472382;7169.964150179216;6913.481488888253;6996.965015175095;7023.122109736283;7074.398676112588;7093;6494.902576461452;6514.837129071621;6609.405153536205;6615.966920165369;6720.731170753115;4927.9507204927495;4935.827246046371;4938.654294199515;4990.80036798524;5012.924806127838;4681.110588988081;4712;4721;4751.453582837879;4754.381930349033 23:00:53 INFO - PROCESS | 20553 | |4;prototype.html;290.42061088129185;306.4575701009213;308.04352485532434;311.51092784328614;312.02958798137786;4858.246971719389;4970.229614409773;5036.219385995172;5078.689196415631;5079.542841144301;4989.65072444929;4995.700257984524;5007.023630392075;5018.573421259188;5035.647504674675;3950.7629542227414;3964.5638979712207;3975.463312452811;3980.840766369342;3994.680425565962;3816.664167541352;3892.1484080973364;3946.4080387941754;3965.8413663453425;3967.26605577969;3865.226954609075;3867.903302417434;3869.187470631171;3876.3447038778527;3885.7177131546664;3869.941950870739;3871.5675200175974;3875.302445559798;3890.961090389088;3892.046448620078;3401.727861771077;3408.454647256452;3411.8635254589785;3413;3422.709069729076;4623;4809.398825146856;4829.299751536043;4839.298301746262;4844.442889067767;4461.304704212411;4490.146872094291;4494.000169924385;4497.605742219889;4505.805961420227;5238.659487133325;5250.474952504757;5258.55302299305;5271.209318602202;5292.603054770908;3668.5781135169264;3756.2299728555854;3766.303233901737;3768.566614839274;3781.6029316921604;5447.809326673548;5474.890502189934;5481.890362192774;5493.121100623881;5536.4186760389985;3842.2891765023;3853.672437842759;3863.671587915059;3871.909169048682;3898.5516665583823;3871.903202419962;3877.6703980161437;3902.414637804295;3907.8046097695;3917;4300.8709738707885;4463.285874260103;4463.794775410621;4469.7318160910445;4475.597196252353;5199.66202196856;5241.764120614582;5243.370795504564;5248.6325957182635;5294.152935530374;1305.536534530228;1336.385262779113;1371.9725605487833;1372.4647387518876;1373.3064802274787;865.9220670139717;888.3781353052759;893.9418937769025;896.9865452018225;905.0542183418212;4156.521999969982;4189.392538082022;4190.700882726364;4207.2539895943455;4216.620504154579;4781.784819683123;4826.6621336506105;4830.855074347775;4850;4884.218525036048;4149.257311928997;4178.1643671265865;4182.1844740275355;4203.43253660758;4209.621134097946;2462.581361168606;2556.782673472738;2577.2268319504446;2585.50875333686;2596.5326241276375;4473.5526447355005;4503.279475283939;4521;4551.886202844956;4561.015958058255;4891.902161956741;4896.698551680704;4908.11653902301;4918.3360246367;4974.90050198994;4318.546552611931;4525.366448697251;4533.098816757278;4537.933585607379;4552.521985191507;4807.831725889577;4836.830710925101;4859.246816743411;4864.659473836798;4886.755662216804;4705.705930869039;4711.623070154448;4742.312364707029;4753.524647535219;4805.591524720298;4567.264439512964;4799.952000479951;5188;5197.376314842092;5198.922016169685;3834.9041273968373;3846.788426636562;3858.074062225102;3862.0731024554466;3879.709021823431;5226.503482169188;5383.380911195262;5428.755705993319;5456.590755693418;5467.425920278472;5165.431802501646;5270.973645131749;5274.86812829667;5280.075986702389;5286.286351342674;5255.658382205144;5255.763490642854;5264.842054738364;5274.947250527445;5292.497212764782;5096.694198347963;5189.532942035084;5191.870203244949;5208.479152084761;5236.162214045735;5269.394019687632;5286.577073834007;5307.814226502208;5327.840164795062;5331.706756128295;5182.844514664566;5191.402988656353;5214.9478505214465;5229.92155117666;5264.63147579681 23:00:53 INFO - PROCESS | 20553 | |5;yui.html;672.2067959807426;723.8118089296781;759.3659294489102;810.6311628209165;824.8432797768427;12046.457909394076;12530.561430349928;12564.874351256485;12586.811197832028;14202.218877961708;13532.120412173203;13717.45130194791;13816.723665526684;13838.308084595781;13948.511802086929;683.3986092238848;885.6944354197824;888.0364804187432;888.9822203555925;890.1543533643065;868.4702331577764;892.2727976698969;894.5616647842576;894.6421431427416;896.6413434626137;921.1387352825096;921.5346250143668;926.2913870888775;927.0775578299567;930.0467021303184;907.6142639378238;914.5107367558325;916.4592890194783;919.0901008002097;920.6041402197053;673.7641825361134;675.2538445018233;675.5541342713834;677.3159109299594;678.1590827374021;13378.197308161542;13438;13475.595732128051;13483.66290842727;13525.797113043312;12823.935880320632;12863.099583029192;12994;13084.934575327157;13128.86871131286;9863.950680246624;9867.96386379427;10134.797304053951;10141;10168.847467287997;3359.781614195094;3368.747343949189;3394.304167645627;3427.537282466885;3430.828458577061;44989;45319.32021019687;45617;48604.27093593599;48900.99999999964;10667.413292269;10739.624113156158;10888.128949684005;10926.016658500774;10980.231383803217;19503.219871205278;19643;19755.703664445045;19838.206471741258;19850.70223946642;7106.751263705745;7154.713811447484;7169.7849064528145;7229.2770722928335;7266.92733072673;3666.7066634669163;3691.077230692327;3717.070732316921;3727.6272372762505;3741.345264578688;3014.8794048238265;3093.211231136091;3121.9843900780807;3126.4059828632944;3126.8592913318957;507.93650793650795;521.4811262793469;532.2282690099371;532.2575007864008;534.8769782949944;598.6168851934765;613.5490414545395;622.7882519943241;624.8781487609963;631.6810010944444;8341.332693384515;8559.572021398904;8722.389432739774;8725.432846864933;8898.243649289883;621.1211136242257;623.9126522286883;633.47105167185;635.293064965929;635.6535688050024;3899.2786334528205;3941.4087886816633;4024.5792462826103;4094.590540945941;4136.710430269853;55588;55828.16257756137;56253.43746562482;56454;56749.71625141848;50708.23937640939;50828;51508.227376589384;51876.74061629743;52135;46944.295835562494;47023.29465058027;47611.285830712564;47945.5205447948;48590.27114593213;7553.131389890233;7604.163542010264;7698.0762308523335;7772.339351154989;7802.843943120993;31324.843375782973;31458.37083258276;31474.842625786725;31571.842140789147;31764.04707858768;37442;41062.79468602638;41746.58253417548;41850.37224441575;42246.7887660572;10174.13519850821;10392.42841643717;10511.211659125749;10533.262671612914;10598.470076496298;10696.679099627023;10759.30064545802;10955.287906286067;11110.61112861046;11189.384583847966;10049.397036177852;10066.295359324777;10282.177425806067;10408.427536485264;10743.301685390425;10129.746756331151;10289.9485502572;10557.9472102639;10557.9472102639;11087;10213.08082272599;10373;10392.844107338246;10411.168217808174;10455.268131230741;8983.416077954913;9037.728868133967;9103.726888193365;9127.908720912706;9222.95388523053;8367.497950123012;8831.91168088311;8863.556822158736;8876.51179185151;8910.910890891268 23:00:53 INFO - PROCESS | 20553 | __end_tp_report 23:00:53 INFO - PROCESS | 20553 | __start_cc_report 23:00:53 INFO - PROCESS | 20553 | _x_x_mozilla_cycle_collect,372 23:00:53 INFO - PROCESS | 20553 | __end_cc_report 23:00:53 INFO - PROCESS | 20553 | __startTimestamp1463464853919__endTimestamp 23:00:53 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | ------- Summary: start ------- 23:00:53 INFO - PROCESS | 20553 | Number of tests: 6 23:00:53 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | [#0] dojo.html Cycles:165 Average:4736.48 Median:4873.37 stddev:511.09 (10.5%) stddev-sans-first:485.88 23:00:53 INFO - PROCESS | 20553 | Values: 2655.0 2682.3 2706.4 2707.7 2712.5 4700.1 4726.1 4744.6 4829.2 4865.1 4709.4 4758.0 4764.1 4819.6 4826.0 4378.6 4426.4 4430.7 4443.8 4472.8 4428.0 4437.5 4450.4 4451.8 4459.2 4261.2 4448.1 4491.3 4492.6 4527.3 4418.1 4431.4 4435.1 4450.1 4450.1 4388.0 4394.8 4399.8 4423.8 4438.2 4637.8 4645.6 4684.6 4684.8 4700.8 5159.1 5194.2 5197.6 5201.9 5215.6 5106.8 5130.6 5137.0 5174.8 5191.9 4688.1 4692.9 4696.8 4739.2 4798.2 5169.8 5175.7 5179.2 5182.1 5239.4 4932.6 4948.5 4977.1 4996.0 5006.5 5063.9 5119.9 5163.3 5192.2 5210.3 5124.0 5141.3 5151.3 5153.7 5216.3 4984.1 5132.8 5139.3 5152.0 5169.7 4059.6 4121.1 4129.0 4157.9 4183.2 3624.9 3647.1 3665.2 3675.8 3712.0 4486.9 4492.5 4501.1 4507.5 4520.2 5047.4 5112.2 5125.7 5151.9 5219.8 4381.3 4383.7 4387.2 4395.4 4434.9 4636.0 4670.4 4670.9 4671.2 4711.6 4773.9 4794.2 4847.9 4853.7 4875.1 5154.7 5159.2 5168.3 5183.8 5217.6 4776.8 4863.9 4874.1 4874.4 4881.2 5079.5 5090.5 5107.8 5116.4 5151.4 5195.2 5198.0 5199.1 5232.7 5260.9 4911.9 4913.4 5021.1 5036.2 5043.0 4979.8 4988.5 4990.3 4999.4 5055.9 4873.4 4895.1 4899.1 4918.6 4994.6 4952.9 5014.0 5037.4 5057.6 5103.4 4792.4 4974.7 4975.1 5004.6 5039.4 23:00:53 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | [#1] ext.html Cycles:180 Average:41426.85 Median:33819.75 stddev:70417.80 (208.2%) stddev-sans-first:70548.44 23:00:53 INFO - PROCESS | 20553 | Values: 546.1 604.9 608.1 613.7 638.8 37089.8 41492.2 41565.8 41652.6 41679.8 40806.8 41553.0 41778.4 41866.8 41882.0 7917.7 8051.1 8055.9 8064.5 8074.7 7888.0 7960.9 7975.3 7977.1 7994.5 7898.5 7914.3 7922.6 7952.6 7953.9 7917.0 7936.4 7942.2 7980.3 8016.4 7974.4 8041.8 8046.5 8048.5 8075.2 31182.2 38578.2 39136.2 39142.2 39362.4 3076.8 3189.4 3190.1 3233.4 3295.0 28685.4 28865.6 29173.4 30016.5 30290.4 3320.5 3321.3 3371.6 3432.7 3510.9 228216.0 230005.0 230738.0 231265.0 231874.8 33855.8 33885.5 34086.7 34815.7 35029.1 33703.7 33783.7 33931.7 33993.8 34004.0 13992.5 14140.5 14145.0 14151.1 14170.0 11607.8 11622.2 11653.8 11697.9 11733.5 8297.5 8375.3 8376.2 8423.4 8464.0 3321.5 3325.7 3328.4 3361.5 3364.6 947.2 974.0 1027.0 1053.4 1085.3 27869.3 28216.7 28434.7 28449.9 28706.0 963.5 984.8 1001.6 1087.9 1106.8 15015.3 15338.2 15357.2 15503.5 15624.1 300305.0 303642.0 304688.0 305966.0 307799.0 32587.8 32945.3 33079.8 33144.8 33372.7 1235.2 1276.9 1284.2 1293.0 1325.6 26035.7 27137.0 27882.6 27944.2 28223.6 42433.6 42507.0 42722.0 42861.8 43055.0 267055.0 267188.0 268338.0 268557.0 268797.0 25508.4 25512.7 26000.3 26025.3 26066.7 41553.0 41985.6 42226.4 42376.6 43420.0 36146.1 36443.6 36701.8 37113.0 37309.6 36093.8 36593.6 36773.6 37000.8 37751.8 35538.3 35926.6 36349.0 36385.3 36640.8 31802.5 33425.7 33436.0 33470.7 33948.7 24470.8 25133.0 25279.5 25370.6 25550.0 23:00:53 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | [#2] jquery.html Cycles:180 Average:23753.98 Median:190669.97 stddev:61486.62 (32.2%) stddev-sans-first:61634.05 23:00:53 INFO - PROCESS | 20553 | Values: 377.5 379.0 385.9 395.2 403.2 15790.1 17187.3 17856.7 17872.1 17918.0 17020.6 17377.2 17821.4 17887.8 17924.4 5195.4 5312.9 5331.7 5358.9 5360.4 3715.5 5886.3 6235.8 6242.3 6284.0 6029.8 6206.2 6225.8 6264.7 6269.3 6129.3 6175.1 6185.5 6188.8 6211.6 5322.8 5445.0 5456.7 5474.6 5502.5 20541.8 21140.9 21250.9 21259.0 21489.9 2044.3 2059.5 2069.0 2083.4 2249.9 13412.3 13690.9 13815.2 13901.8 13926.9 1683.4 1770.0 1835.2 1835.8 1919.7 70556.3 72483.6 72855.0 73283.0 73432.3 9795.6 9912.2 9947.5 9989.5 10303.2 13860.4 14022.8 14061.1 14102.4 14114.2 7428.3 7629.2 7800.5 7850.0 7868.6 7217.4 7232.0 7386.7 7403.7 7429.7 5636.9 6293.6 6293.7 6413.6 6528.2 1693.0 1842.6 1888.3 1908.8 1925.8 868.7 876.1 902.9 905.0 964.2 16444.0 16745.4 16818.0 17069.4 17290.6 895.5 935.3 936.2 973.9 999.1 9775.9 9827.6 9935.5 10025.5 10214.7 363844.0 367768.0 374683.0 380662.0 380954.0 65554.3 66618.3 68530.3 68910.0 69627.3 976.5 979.2 986.0 990.4 995.6 15356.5 15372.0 15386.2 15474.4 15665.1 26900.6 33660.5 34295.7 34716.7 35278.1 41496.8 42227.6 43889.6 44410.0 44437.3 7510.1 7768.4 7798.7 7939.6 8036.8 11736.7 11802.6 11833.2 11845.6 11847.5 10324.0 10424.9 10599.3 10655.1 10778.4 10223.0 10406.2 10493.5 10524.6 10584.2 10460.6 10668.9 10769.2 10792.6 10861.4 7525.6 7723.0 7726.0 7779.6 7833.5 10465.3 10639.6 10680.5 10784.4 10848.6 23:00:53 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | [#3] mootools.html Cycles:180 Average:5166.90 Median:5493.17 stddev:2853.33 (51.9%) stddev-sans-first:2847.95 23:00:53 INFO - PROCESS | 20553 | Values: 1489.5 1510.2 1689.9 1793.1 1822.5 6657.6 7540.5 7689.8 8172.7 8176.5 7547.8 7733.5 7862.2 7880.6 7945.9 2168.7 2225.6 2229.2 2229.2 2231.5 2177.4 2211.7 2235.3 2237.0 2240.7 2213.0 2216.4 2222.6 2222.8 2240.8 2061.5 2066.9 2076.3 2080.6 2083.2 2150.8 2200.5 2200.9 2201.2 2201.8 7909.3 7976.0 7976.4 8019.0 8041.0 4371.6 4484.2 4488.1 4489.8 4502.4 2798.2 2823.4 2918.4 2922.0 2927.0 832.9 891.8 893.8 896.7 901.6 10763.3 10918.6 11016.9 11028.8 11043.1 4171.3 4301.9 4380.7 4410.9 4414.9 8602.2 8658.8 8666.0 8716.5 8752.5 4755.4 4762.9 4763.0 4764.9 4768.0 3856.0 4254.2 4386.2 4421.0 4460.4 3304.2 3328.0 3335.5 3386.4 3389.7 999.1 1015.0 1016.0 1017.4 1035.5 801.9 839.1 865.3 867.9 921.4 5135.9 5233.5 5253.4 5277.3 5289.2 856.1 875.3 892.3 908.2 960.9 3699.1 3736.8 3780.0 3782.2 3784.7 9025.1 9246.4 9292.8 9388.6 9498.0 9255.1 9265.1 9268.7 9314.8 9331.7 7157.7 7464.9 7469.3 7613.9 7667.4 5314.9 5434.7 5551.7 5635.4 5705.5 8392.7 8513.7 8540.3 8788.4 8802.3 8644.9 8761.7 8763.9 8789.7 8885.4 6048.8 6642.7 6677.4 6791.2 6827.0 7574.6 7687.7 7789.3 7856.6 7863.4 6833.6 7026.7 7070.9 7086.5 7170.0 6913.5 6997.0 7023.1 7074.4 7093.0 6494.9 6514.8 6609.4 6616.0 6720.7 4928.0 4935.8 4938.7 4990.8 5012.9 4681.1 4712.0 4721.0 4751.5 4754.4 23:00:53 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | [#4] prototype.html Cycles:180 Average:4238.88 Median:4595.13 stddev:1222.66 (26.6%) stddev-sans-first:1189.63 23:00:53 INFO - PROCESS | 20553 | Values: 290.4 306.5 308.0 311.5 312.0 4858.2 4970.2 5036.2 5078.7 5079.5 4989.7 4995.7 5007.0 5018.6 5035.6 3950.8 3964.6 3975.5 3980.8 3994.7 3816.7 3892.1 3946.4 3965.8 3967.3 3865.2 3867.9 3869.2 3876.3 3885.7 3869.9 3871.6 3875.3 3891.0 3892.0 3401.7 3408.5 3411.9 3413.0 3422.7 4623.0 4809.4 4829.3 4839.3 4844.4 4461.3 4490.1 4494.0 4497.6 4505.8 5238.7 5250.5 5258.6 5271.2 5292.6 3668.6 3756.2 3766.3 3768.6 3781.6 5447.8 5474.9 5481.9 5493.1 5536.4 3842.3 3853.7 3863.7 3871.9 3898.6 3871.9 3877.7 3902.4 3907.8 3917.0 4300.9 4463.3 4463.8 4469.7 4475.6 5199.7 5241.8 5243.4 5248.6 5294.2 1305.5 1336.4 1372.0 1372.5 1373.3 865.9 888.4 893.9 897.0 905.1 4156.5 4189.4 4190.7 4207.3 4216.6 4781.8 4826.7 4830.9 4850.0 4884.2 4149.3 4178.2 4182.2 4203.4 4209.6 2462.6 2556.8 2577.2 2585.5 2596.5 4473.6 4503.3 4521.0 4551.9 4561.0 4891.9 4896.7 4908.1 4918.3 4974.9 4318.5 4525.4 4533.1 4537.9 4552.5 4807.8 4836.8 4859.2 4864.7 4886.8 4705.7 4711.6 4742.3 4753.5 4805.6 4567.3 4800.0 5188.0 5197.4 5198.9 3834.9 3846.8 3858.1 3862.1 3879.7 5226.5 5383.4 5428.8 5456.6 5467.4 5165.4 5271.0 5274.9 5280.1 5286.3 5255.7 5255.8 5264.8 5274.9 5292.5 5096.7 5189.5 5191.9 5208.5 5236.2 5269.4 5286.6 5307.8 5327.8 5331.7 5182.8 5191.4 5214.9 5229.9 5264.6 23:00:53 INFO - PROCESS | 20553 | 23:00:53 INFO - PROCESS | 20553 | [#5] yui.html Cycles:180 Average:13412.60 Median:46280.65 stddev:15594.49 (33.7%) stddev-sans-first:15608.88 23:00:53 INFO - PROCESS | 20553 | Values: 672.2 723.8 759.4 810.6 824.8 12046.5 12530.6 12564.9 12586.8 14202.2 13532.1 13717.5 13816.7 13838.3 13948.5 683.4 885.7 888.0 889.0 890.2 868.5 892.3 894.6 894.6 896.6 921.1 921.5 926.3 927.1 930.0 907.6 914.5 916.5 919.1 920.6 673.8 675.3 675.6 677.3 678.2 13378.2 13438.0 13475.6 13483.7 13525.8 12823.9 12863.1 12994.0 13084.9 13128.9 9864.0 9868.0 10134.8 10141.0 10168.8 3359.8 3368.7 3394.3 3427.5 3430.8 44989.0 45319.3 45617.0 48604.3 48901.0 10667.4 10739.6 10888.1 10926.0 10980.2 19503.2 19643.0 19755.7 19838.2 19850.7 7106.8 7154.7 7169.8 7229.3 7266.9 3666.7 3691.1 3717.1 3727.6 3741.3 3014.9 3093.2 3122.0 3126.4 3126.9 507.9 521.5 532.2 532.3 534.9 598.6 613.5 622.8 624.9 631.7 8341.3 8559.6 8722.4 8725.4 8898.2 621.1 623.9 633.5 635.3 635.7 3899.3 3941.4 4024.6 4094.6 4136.7 55588.0 55828.2 56253.4 56454.0 56749.7 50708.2 50828.0 51508.2 51876.7 52135.0 46944.3 47023.3 47611.3 47945.5 48590.3 7553.1 7604.2 7698.1 7772.3 7802.8 31324.8 31458.4 31474.8 31571.8 31764.0 37442.0 41062.8 41746.6 41850.4 42246.8 10174.1 10392.4 10511.2 10533.3 10598.5 10696.7 10759.3 10955.3 11110.6 11189.4 10049.4 10066.3 10282.2 10408.4 10743.3 10129.7 10289.9 10557.9 10557.9 11087.0 10213.1 10373.0 10392.8 10411.2 10455.3 8983.4 9037.7 9103.7 9127.9 9223.0 8367.5 8831.9 8863.6 8876.5 8910.9 23:00:53 INFO - PROCESS | 20553 | -------- Summary: end -------- 23:00:53 INFO - PROCESS | 20553 | 23:00:54 INFO - TEST-INFO | 20553: exit 0 23:00:54 INFO - TEST-OK | dromaeo_css | took 1116320ms 23:00:54 INFO - TEST-START | kraken 23:00:54 INFO - operating with platform_type : linux_ 23:00:54 INFO - Initialising browser for kraken test... 23:00:54 INFO - TEST-INFO | started process 20784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmSrZDx/profile http://localhost:60139/getInfo.html) 23:00:58 INFO - PROCESS | 20784 | 23:00:58 INFO - PROCESS | 20784 | (process:20852): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:00:59 INFO - PROCESS | 20784 | __metrics Screen width/height:1600/1200 23:00:59 INFO - PROCESS | 20784 | colorDepth:24 23:00:59 INFO - PROCESS | 20784 | Browser inner width/height: 1024/697 23:00:59 INFO - PROCESS | 20784 | __metrics 23:01:00 ERROR - PROCESS | 20784 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:01:01 INFO - TEST-INFO | 20784: exit 0 23:01:01 INFO - Browser initialized. 23:01:01 INFO - Running cycle 1/1 for kraken test... 23:01:01 INFO - TEST-INFO | started process 20903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmSrZDx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:03 INFO - PROCESS | 20903 | 23:01:03 INFO - PROCESS | 20903 | (process:20963): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:01:13 INFO - PROCESS | 20903 | RSS: Main: 164478976 23:01:13 INFO - PROCESS | 20903 | 23:01:15 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60139/tests/kraken/driver.html?testName=audio-beat-detection) 23:01:16 INFO - PROCESS | 20903 | RSS: Main: 167956480 23:01:16 INFO - PROCESS | 20903 | 23:01:19 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60139/tests/kraken/driver.html?testName=audio-dft) 23:01:20 INFO - PROCESS | 20903 | RSS: Main: 167931904 23:01:20 INFO - PROCESS | 20903 | 23:01:23 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60139/tests/kraken/driver.html?testName=audio-fft) 23:01:23 INFO - PROCESS | 20903 | RSS: Main: 164237312 23:01:23 INFO - PROCESS | 20903 | 23:01:26 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60139/tests/kraken/driver.html?testName=audio-oscillator) 23:01:26 INFO - PROCESS | 20903 | RSS: Main: 164212736 23:01:26 INFO - PROCESS | 20903 | 23:01:29 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60139/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:01:29 INFO - PROCESS | 20903 | RSS: Main: 164339712 23:01:29 INFO - PROCESS | 20903 | 23:01:32 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60139/tests/kraken/driver.html?testName=imaging-darkroom) 23:01:33 INFO - PROCESS | 20903 | RSS: Main: 164610048 23:01:33 INFO - PROCESS | 20903 | 23:01:37 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60139/tests/kraken/driver.html?testName=imaging-desaturate) 23:01:37 INFO - PROCESS | 20903 | RSS: Main: 162828288 23:01:37 INFO - PROCESS | 20903 | 23:01:40 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60139/tests/kraken/driver.html?testName=json-parse-financial) 23:01:41 INFO - PROCESS | 20903 | RSS: Main: 163946496 23:01:41 INFO - PROCESS | 20903 | 23:01:43 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60139/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:01:43 INFO - PROCESS | 20903 | RSS: Main: 164315136 23:01:43 INFO - PROCESS | 20903 | 23:01:45 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60139/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:01:46 INFO - PROCESS | 20903 | RSS: Main: 164167680 23:01:46 INFO - PROCESS | 20903 | 23:01:48 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60139/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:01:49 INFO - PROCESS | 20903 | RSS: Main: 164392960 23:01:49 INFO - PROCESS | 20903 | 23:01:52 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:01:52 INFO - PROCESS | 20903 | RSS: Main: 164438016 23:01:52 INFO - PROCESS | 20903 | 23:01:55 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:01:56 INFO - PROCESS | 20903 | RSS: Main: 164171776 23:01:56 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | Cycle 1(1): loaded http://localhost:60139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60139/tests/kraken/driver.html?testName=ai-astar) 23:01:58 INFO - PROCESS | 20903 | RSS: Main: 165773312 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | __start_tp_report 23:01:58 INFO - PROCESS | 20903 | _x_x_mozilla_page_load 23:01:58 INFO - PROCESS | 20903 | _x_x_mozilla_page_load_details 23:01:58 INFO - PROCESS | 20903 | |i|pagename|runs| 23:01:58 INFO - PROCESS | 20903 | |0;ai-astar;112;116;108;115;115;115;109;117;115;115 23:01:58 INFO - PROCESS | 20903 | |1;audio-beat-detection;166;135;160;218;131;158;158;132;188;150 23:01:58 INFO - PROCESS | 20903 | |2;audio-dft;164;168;172;167;164;164;163;164;165;164 23:01:58 INFO - PROCESS | 20903 | |3;audio-fft;77;74;76;165;76;75;76;79;161;78 23:01:58 INFO - PROCESS | 20903 | |4;audio-oscillator;94;93;168;93;98;93;143;94;93;139 23:01:58 INFO - PROCESS | 20903 | |5;imaging-gaussian-blur;117;118;120;118;117;118;118;117;118;118 23:01:58 INFO - PROCESS | 20903 | |6;imaging-darkroom;147;148;148;147;147;147;147;146;146;147 23:01:58 INFO - PROCESS | 20903 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;95 23:01:58 INFO - PROCESS | 20903 | |8;json-parse-financial;65;65;64;64;69;64;63;65;64;66 23:01:58 INFO - PROCESS | 20903 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;64;63;64 23:01:58 INFO - PROCESS | 20903 | |10;stanford-crypto-aes;82;87;81;83;87;83;90;84;137;84 23:01:58 INFO - PROCESS | 20903 | |11;stanford-crypto-ccm;130;141;140;130;147;140;133;136;158;145 23:01:58 INFO - PROCESS | 20903 | |12;stanford-crypto-pbkdf2;172;180;172;175;177;171;172;174;169;169 23:01:58 INFO - PROCESS | 20903 | |13;stanford-crypto-sha256-iterative;68;67;69;66;67;71;67;69;66;66 23:01:58 INFO - PROCESS | 20903 | __end_tp_report 23:01:58 INFO - PROCESS | 20903 | __start_cc_report 23:01:58 INFO - PROCESS | 20903 | _x_x_mozilla_cycle_collect,922 23:01:58 INFO - PROCESS | 20903 | __end_cc_report 23:01:58 INFO - PROCESS | 20903 | __startTimestamp1463464918361__endTimestamp 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | ------- Summary: start ------- 23:01:58 INFO - PROCESS | 20903 | Number of tests: 14 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.02 (2.6%) stddev-sans-first:3.14 23:01:58 INFO - PROCESS | 20903 | Values: 112.0 116.0 108.0 115.0 115.0 115.0 109.0 117.0 115.0 115.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#1] audio-beat-detection Cycles:10 Average:159.60 Median:159.00 stddev:26.96 (17.0%) stddev-sans-first:28.49 23:01:58 INFO - PROCESS | 20903 | Values: 166.0 135.0 160.0 218.0 131.0 158.0 158.0 132.0 188.0 150.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#2] audio-dft Cycles:10 Average:165.50 Median:164.50 stddev:2.76 (1.7%) stddev-sans-first:2.87 23:01:58 INFO - PROCESS | 20903 | Values: 164.0 168.0 172.0 167.0 164.0 164.0 163.0 164.0 165.0 164.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:36.56 (48.1%) stddev-sans-first:38.28 23:01:58 INFO - PROCESS | 20903 | Values: 77.0 74.0 76.0 165.0 76.0 75.0 76.0 79.0 161.0 78.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:93.00 stddev:28.09 (30.2%) stddev-sans-first:29.12 23:01:58 INFO - PROCESS | 20903 | Values: 94.0 93.0 168.0 93.0 98.0 93.0 143.0 94.0 93.0 139.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 23:01:58 INFO - PROCESS | 20903 | Values: 117.0 118.0 120.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:01:58 INFO - PROCESS | 20903 | Values: 147.0 148.0 148.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:01:58 INFO - PROCESS | 20903 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.66 (2.6%) stddev-sans-first:1.76 23:01:58 INFO - PROCESS | 20903 | Values: 65.0 65.0 64.0 64.0 69.0 64.0 63.0 65.0 64.0 66.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 23:01:58 INFO - PROCESS | 20903 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:84.00 stddev:16.80 (20.0%) stddev-sans-first:17.59 23:01:58 INFO - PROCESS | 20903 | Values: 82.0 87.0 81.0 83.0 87.0 83.0 90.0 84.0 137.0 84.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:140.50 stddev:8.59 (6.1%) stddev-sans-first:8.31 23:01:58 INFO - PROCESS | 20903 | Values: 130.0 141.0 140.0 130.0 147.0 140.0 133.0 136.0 158.0 145.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.00 stddev:3.48 (2.0%) stddev-sans-first:3.67 23:01:58 INFO - PROCESS | 20903 | Values: 172.0 180.0 172.0 175.0 177.0 171.0 172.0 174.0 169.0 169.0 23:01:58 INFO - PROCESS | 20903 | 23:01:58 INFO - PROCESS | 20903 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.65 (2.4%) stddev-sans-first:1.74 23:01:58 INFO - PROCESS | 20903 | Values: 68.0 67.0 69.0 66.0 67.0 71.0 67.0 69.0 66.0 66.0 23:01:58 INFO - PROCESS | 20903 | -------- Summary: end -------- 23:01:58 INFO - PROCESS | 20903 | 23:01:59 INFO - TEST-INFO | 20903: exit 0 23:01:59 INFO - TEST-OK | kraken | took 64848ms 23:01:59 INFO - SUITE-END | took 1181s 23:02:00 INFO - Completed test suite (00:19:41) 23:02:00 INFO - javascript benchmark 23:02:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6340.703288115989, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2655.0309137164936, 2682.2891933637584, 2706.350475885788, 2707.6750789905213, 2712.4846279206963, 4700.106979673864, 4726.125666751654, 4744.57298843104, 4829.22732362822, 4865.124277630025, 4709.411323584552, 4757.952420475803, 4764.094821983821, 4819.590334821544, 4826.0, 4378.6497080233585, 4426.358178064179, 4430.667699922503, 4443.822247110128, 4472.753998530079, 4428.047969686517, 4437.534058923815, 4450.376947227391, 4451.844185453509, 4459.241928872083, 4261.190373828963, 4448.132614140244, 4491.25894227452, 4492.573205545468, 4527.253003254459, 4418.072204836988, 4431.401760762288, 4435.112977404499, 4450.087732014929, 4450.087732014961, 4387.978060109711, 4394.846180383671, 4399.846005389828, 4423.7566933818625, 4438.223310920576, 4637.814487420499, 4645.605123564501, 4684.648651351163, 4684.836030738942, 4700.811967521295, 5159.097157997336, 5194.168932970707, 5197.610179236534, 5201.895962080737, 5215.608829337815, 5106.846794596168, 5130.563902068328, 5137.049645815536, 5174.844754657366, 5191.922121168185, 4688.109259240733, 4692.906141877143, 4696.8121275148615, 4739.170645137122, 4798.184308667535, 5169.7932082717025, 5175.689458632494, 5179.171332586768, 5182.119039763249, 5239.44985776488, 4932.605391568666, 4948.480409556944, 4977.104121258209, 4996.025774973918, 5006.4743201964, 5063.949360506422, 5119.87200319995, 5163.277141200235, 5192.169252919514, 5210.322658054504, 5124.0, 5141.28022076902, 5151.330327057459, 5153.6907785532985, 5216.26972223889, 4984.127777638899, 5132.769025393866, 5139.254808052886, 5151.974240128776, 5169.715665638426, 4059.6143366380147, 4121.1345617420675, 4129.0, 4157.8960525987095, 4183.205191013698, 3624.9456258156147, 3647.0882279430143, 3665.248624032067, 3675.761075530082, 3711.9628803712158, 4486.910261794746, 4492.528284530143, 4501.077279157765, 4507.481639611421, 4520.163769702615, 5047.369078865142, 5112.156494178494, 5125.666831655931, 5151.896962060738, 5219.791208351699, 4381.3208952612395, 4383.693141480129, 4387.166438376698, 4395.428594282723, 4434.933475997863, 4635.95364046362, 4670.369500117508, 4670.859874203711, 4671.18254305502, 4711.599514041345, 4773.856784296477, 4794.161021821167, 4847.854564363075, 4853.684510506806, 4875.07373599015, 5154.690718556749, 5159.226116082617, 5168.250603662373, 5183.844484665466, 5217.634765566374, 4776.785044672929, 4863.878403039811, 4874.073925954058, 4874.439439464507, 4881.243407271879, 5079.492050794891, 5090.516400941905, 5107.770150343169, 5116.411612664591, 5151.356080489939, 5195.220716892496, 5198.012377648386, 5199.090159222045, 5232.659877107976, 5260.921086183634, 4911.852644420673, 4913.385826771653, 5021.096202683406, 5036.194208926554, 5042.974785126051, 4979.800807967786, 4988.501149884983, 4990.326305948651, 4999.350084488993, 5055.9494405055475, 4873.366462359871, 4895.094407534618, 4899.069176856386, 4918.6065114791445, 4994.550490455877, 4952.8761780955765, 5014.0, 5037.370328708911, 5057.595392368676, 5103.362079740033, 4792.448868380181, 4974.676646017997, 4975.10448119342, 5004.624653150955, 5039.420466646383], "value": 4703.116405173398, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.1289243656369, 604.926255895785, 608.0726891490477, 613.6502193749564, 638.7891995641439, 37089.81455092727, 41492.17015659685, 41565.79217103914, 41652.58347416525, 41679.79160104203, 40806.7959660202, 41553.0, 41778.373324400156, 41866.790666046625, 41882.0, 7917.683292668301, 8051.114377418479, 8055.879161812578, 8064.516129032248, 8074.6770129194765, 7888.0, 7960.920390796105, 7975.322097621709, 7977.122516523178, 7994.480358776661, 7898.5260884346835, 7914.28771410573, 7922.643481043367, 7952.602369881512, 7953.880691789628, 7916.960415197887, 7936.44444888858, 7942.166072562384, 7980.281774640282, 8016.438849280553, 7974.441789074767, 8041.839163216761, 8046.517208967481, 8048.5170889746805, 8075.152109028585, 31182.22044448884, 38578.228435431134, 39136.21727565461, 39142.21715565701, 39362.40956385656, 3076.769242306836, 3189.378071276102, 3190.1291076892508, 3233.3856567252383, 3295.0279667498144, 28685.42629147426, 28865.56701649456, 29173.41653166925, 30016.54975175374, 30290.394192116255, 3320.518524813913, 3321.285923526429, 3371.578552680915, 3432.6910578047846, 3510.912227194315, 228216.0, 230005.0, 230738.0, 231265.0, 231874.8406257975, 33855.83072084673, 33885.49171762425, 34086.65913340835, 34815.65184348124, 35029.12427189341, 33703.662963370545, 33783.66216337854, 33931.66068339335, 33993.83003084969, 34004.0, 13992.510262140777, 14140.50508232207, 14145.0, 14151.080179788281, 14170.0, 11607.825882611767, 11622.244554103956, 11653.766924661459, 11697.941510292394, 11733.4719937603, 8297.543635100006, 8375.288100511403, 8376.204260595234, 8423.410361274651, 8464.0, 3321.5017747338093, 3325.6840600143432, 3328.367610154063, 3361.46216605342, 3364.596248450153, 947.209080417845, 973.9610415583297, 1026.994865025685, 1053.4206186597341, 1085.2674444749762, 27869.303267418072, 28216.717832821818, 28434.71565284362, 28449.857750711115, 28706.0, 963.4893506441597, 984.7931934293879, 1001.6043662753171, 1087.8694556653252, 1106.8395082712962, 15015.324310406058, 15338.156401397808, 15357.155356455502, 15503.5348939532, 15624.140672263135, 300305.0, 303642.0, 304688.0, 305966.0, 307799.0, 32587.837060814545, 32945.341093178, 33079.83460082732, 33144.83427582846, 33372.66627333744, 1235.215638069814, 1276.8531618863765, 1284.2102107204003, 1292.9870701293055, 1325.6288239293012, 26035.73964260333, 27137.0, 27882.581761274003, 27944.16167514978, 28223.57664634991, 42433.57566424296, 42507.0, 42722.0, 42861.78569107259, 43055.0, 267055.0, 267188.0, 268338.0, 268557.0, 268797.0, 25508.362290942874, 25512.744872551037, 26000.34999124961, 26025.349366265997, 26066.73933260643, 41553.0, 41985.58014419817, 42226.36660450034, 42376.5762342385, 43420.0, 36146.09634759047, 36443.63556364508, 36701.81649091844, 37113.0, 37309.6269037317, 36093.819530902176, 36593.634063659025, 36773.63226367702, 37000.81499592485, 37751.81124094362, 35538.289234215685, 35926.64073359233, 36349.0, 36385.27229455343, 36640.81679591585, 31802.52296215605, 33425.66574334226, 33436.0, 33470.665293346756, 33948.66051339455, 24470.75529244756, 25133.0, 25279.494410112064, 25370.574972378494, 25550.0], "value": 16267.66589815143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.4828484975582, 378.9790324655406, 385.9421086836974, 395.2391646081293, 403.1714826032502, 15790.131542765143, 17187.312507499715, 17856.732149017775, 17872.106394680264, 17917.999999999985, 17020.574485637866, 17377.218025188864, 17821.37625183119, 17887.821121788777, 17924.372646957327, 5195.350581177362, 5312.92030619541, 5331.680099194061, 5358.892822143554, 5360.383555891083, 3715.479832823407, 5886.323072846613, 6235.781747638811, 6242.25092988842, 6284.0, 6029.758809647609, 6206.224221972254, 6225.782097626561, 6264.718087686065, 6269.279032911205, 6129.264488261437, 6175.135481032659, 6185.474234690057, 6188.762247550485, 6211.565190436671, 5322.760475778599, 5445.0, 5456.699881506515, 5474.644148130359, 5502.477264659851, 20541.79458205429, 21140.89429552858, 21250.893745531328, 21259.0, 21489.892550537304, 2044.3253726270295, 2059.5159291462746, 2069.0, 2083.406229224679, 2249.9437514062115, 13412.329383530785, 13690.863091369058, 13815.240161791098, 13901.79147312791, 13926.860731392657, 1683.3939781678587, 1770.0, 1835.2383760739276, 1835.7613510243716, 1919.7216403621537, 70556.29443705549, 72483.63758181228, 72855.0, 73283.0, 73432.26567734308, 9795.559199836025, 9912.207023438108, 9947.502624868872, 9989.500524973722, 10303.175745940307, 13860.445582176802, 14022.789658155136, 14061.086029408056, 14102.435902563782, 14114.223717695626, 7428.2571742825285, 7629.160792312841, 7800.45396822217, 7850.0, 7868.606569671493, 7217.422606191492, 7232.0, 7386.704531818775, 7403.703851845866, 7429.665665045086, 5636.943630563724, 6293.622382657055, 6293.748250070037, 6413.551051426449, 6528.183977002875, 1692.9746053809204, 1842.640685066399, 1888.2824526679774, 1908.8472922166193, 1925.768907731053, 868.6916144768643, 876.1413814461863, 902.9367944243971, 904.968326108583, 964.2382517810851, 16444.0, 16745.413910513318, 16818.0, 17069.40257090996, 17290.567735806704, 895.4537731983485, 935.2517985611483, 936.1574582875467, 973.9172170365598, 999.0558921818812, 9775.853362199572, 9827.606895724091, 9935.503224838729, 10025.548850301753, 10214.693559193236, 363844.0, 367768.0, 374683.0, 380662.0, 380954.0, 65554.34445655483, 66618.33381666218, 68530.31469685338, 68910.0, 69627.3037269631, 976.5166242709762, 979.1725991536997, 985.9704208873745, 990.4008075114596, 995.5669283861544, 15356.462523811613, 15372.0, 15386.230688465308, 15474.381024758884, 15665.060096394252, 26900.596491053042, 33660.49509257314, 34295.65704343024, 34716.652833471344, 35278.11804704903, 41496.79251603843, 42227.57772422236, 43889.561104388544, 44410.001549929686, 44437.33343999907, 7510.136334321623, 7768.417368697484, 7798.727044553413, 7939.563324017235, 8036.758897233092, 11736.70658233551, 11802.645920622395, 11833.171677982802, 11845.5854045108, 11847.466863990969, 10324.0, 10424.895751042695, 10599.311044782064, 10655.14758819277, 10778.407187604756, 10223.0, 10406.167506599302, 10493.52779124926, 10524.579016839241, 10584.206184536037, 10460.63387781424, 10668.89331106679, 10769.24615276923, 10792.56829726802, 10861.40262285582, 7525.58609276495, 7722.961385193263, 7726.0, 7779.611019448892, 7833.529988200498, 10465.319754216256, 10639.627613033506, 10680.465976701289, 10784.352938823695, 10848.620298289521], "value": 8572.36003236799, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.501017159252, 1510.237330148275, 1689.9239534220958, 1793.0944872839214, 1822.5352535103539, 6657.633830139341, 7540.547567145975, 7689.846203075935, 8172.67309307627, 8176.509409435431, 7547.811304717385, 7733.5359878407335, 7862.174471680462, 7880.645370958307, 7945.880811787828, 2168.728908886393, 2225.554889022202, 2229.1974889039934, 2229.2420577003813, 2231.509068005036, 2177.4447515883426, 2211.7124773779387, 2235.2958817972367, 2236.9888150559223, 2240.7087078679747, 2213.0373287619855, 2216.4348091236793, 2222.588821068108, 2222.75549689534, 2240.798328150466, 2061.5258490547258, 2066.917323307066, 2076.3459510254297, 2080.6462901306813, 2083.2396175396025, 2150.817180539656, 2200.548887478079, 2200.878951657658, 2201.152556265833, 2201.8128459081, 7909.288164065204, 7975.960120199362, 7976.401769867225, 8019.0, 8041.0, 4371.606555409997, 4484.1928452878465, 4488.05750792334, 4489.842855500075, 4502.369668246448, 2798.2444739920106, 2823.449427361665, 2918.4454953558757, 2922.0, 2926.9707302926913, 832.8792325112825, 891.8394688955985, 893.8391089603869, 896.6771962093641, 901.6393442622938, 10763.300385474919, 10918.563257469692, 11016.944915275453, 11028.779424411467, 11043.061339786127, 4171.290880550314, 4301.913961720748, 4380.67144964129, 4410.889727756832, 4414.911701765946, 8602.225799677934, 8658.826823463496, 8665.956670216734, 8716.520591367536, 8752.47485150893, 4755.429348478136, 4762.928556071662, 4762.9523704763205, 4764.857054288377, 4767.976160119247, 3855.9614403856162, 4254.170436764801, 4386.166628340605, 4421.0, 4460.397846290774, 3304.2069903223055, 3327.9500807487907, 3335.4830001349346, 3386.4243078676686, 3389.7288216942584, 999.1017067571672, 1014.9644762433279, 1016.0398423489879, 1017.353980222564, 1035.5236591168148, 801.9438639295194, 839.131498898637, 865.2774932930947, 867.8568036273944, 921.4056933277998, 5135.922961155586, 5233.476652334736, 5253.44838791929, 5277.261183434322, 5289.20661900718, 856.148132608059, 875.3391189651772, 892.2861710631469, 908.1690253418049, 960.8846938367441, 3699.1491956850077, 3736.7944763038295, 3779.962200377961, 3782.167923056923, 3784.6593806557544, 9025.097490251053, 9246.352755307063, 9292.814143717087, 9388.577514011886, 9497.952510237405, 9255.074492550692, 9265.073492650681, 9268.72193834186, 9314.813703725888, 9331.72004839856, 7157.6779044943105, 7464.888026679604, 7469.253074692488, 7613.9238607614325, 7667.386609071261, 5314.8937021260135, 5434.6525173541095, 5551.694656793915, 5635.436456354496, 5705.543556515552, 8392.748217553482, 8513.74458766238, 8540.27407670355, 8788.384813063025, 8802.33982451306, 8644.913550864663, 8761.737147885573, 8763.868541971748, 8789.736307910773, 8885.42244754089, 6048.848778780566, 6642.667866606747, 6677.399034086956, 6791.151106111736, 6826.965865170642, 7574.583397913168, 7687.692492300245, 7789.298963093122, 7856.646450909837, 7863.449558530848, 6833.59025397725, 7026.718931242693, 7070.893936590853, 7086.50394472382, 7169.964150179216, 6913.481488888253, 6996.965015175095, 7023.122109736283, 7074.398676112588, 7093.0, 6494.902576461452, 6514.837129071621, 6609.405153536205, 6615.966920165369, 6720.731170753115, 4927.9507204927495, 4935.827246046371, 4938.654294199515, 4990.80036798524, 5012.924806127838, 4681.110588988081, 4712.0, 4721.0, 4751.453582837879, 4754.381930349033], "value": 4166.054046996881, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.42061088129185, 306.4575701009213, 308.04352485532434, 311.51092784328614, 312.02958798137786, 4858.246971719389, 4970.229614409773, 5036.219385995172, 5078.689196415631, 5079.542841144301, 4989.65072444929, 4995.700257984524, 5007.023630392075, 5018.573421259188, 5035.647504674675, 3950.7629542227414, 3964.5638979712207, 3975.463312452811, 3980.840766369342, 3994.680425565962, 3816.664167541352, 3892.1484080973364, 3946.4080387941754, 3965.8413663453425, 3967.26605577969, 3865.226954609075, 3867.903302417434, 3869.187470631171, 3876.3447038778527, 3885.7177131546664, 3869.941950870739, 3871.5675200175974, 3875.302445559798, 3890.961090389088, 3892.046448620078, 3401.727861771077, 3408.454647256452, 3411.8635254589785, 3413.0, 3422.709069729076, 4623.0, 4809.398825146856, 4829.299751536043, 4839.298301746262, 4844.442889067767, 4461.304704212411, 4490.146872094291, 4494.000169924385, 4497.605742219889, 4505.805961420227, 5238.659487133325, 5250.474952504757, 5258.55302299305, 5271.209318602202, 5292.603054770908, 3668.5781135169264, 3756.2299728555854, 3766.303233901737, 3768.566614839274, 3781.6029316921604, 5447.809326673548, 5474.890502189934, 5481.890362192774, 5493.121100623881, 5536.4186760389985, 3842.2891765023, 3853.672437842759, 3863.671587915059, 3871.909169048682, 3898.5516665583823, 3871.903202419962, 3877.6703980161437, 3902.414637804295, 3907.8046097695, 3917.0, 4300.8709738707885, 4463.285874260103, 4463.794775410621, 4469.7318160910445, 4475.597196252353, 5199.66202196856, 5241.764120614582, 5243.370795504564, 5248.6325957182635, 5294.152935530374, 1305.536534530228, 1336.385262779113, 1371.9725605487833, 1372.4647387518876, 1373.3064802274787, 865.9220670139717, 888.3781353052759, 893.9418937769025, 896.9865452018225, 905.0542183418212, 4156.521999969982, 4189.392538082022, 4190.700882726364, 4207.2539895943455, 4216.620504154579, 4781.784819683123, 4826.6621336506105, 4830.855074347775, 4850.0, 4884.218525036048, 4149.257311928997, 4178.1643671265865, 4182.1844740275355, 4203.43253660758, 4209.621134097946, 2462.581361168606, 2556.782673472738, 2577.2268319504446, 2585.50875333686, 2596.5326241276375, 4473.5526447355005, 4503.279475283939, 4521.0, 4551.886202844956, 4561.015958058255, 4891.902161956741, 4896.698551680704, 4908.11653902301, 4918.3360246367, 4974.90050198994, 4318.546552611931, 4525.366448697251, 4533.098816757278, 4537.933585607379, 4552.521985191507, 4807.831725889577, 4836.830710925101, 4859.246816743411, 4864.659473836798, 4886.755662216804, 4705.705930869039, 4711.623070154448, 4742.312364707029, 4753.524647535219, 4805.591524720298, 4567.264439512964, 4799.952000479951, 5188.0, 5197.376314842092, 5198.922016169685, 3834.9041273968373, 3846.788426636562, 3858.074062225102, 3862.0731024554466, 3879.709021823431, 5226.503482169188, 5383.380911195262, 5428.755705993319, 5456.590755693418, 5467.425920278472, 5165.431802501646, 5270.973645131749, 5274.86812829667, 5280.075986702389, 5286.286351342674, 5255.658382205144, 5255.763490642854, 5264.842054738364, 5274.947250527445, 5292.497212764782, 5096.694198347963, 5189.532942035084, 5191.870203244949, 5208.479152084761, 5236.162214045735, 5269.394019687632, 5286.577073834007, 5307.814226502208, 5327.840164795062, 5331.706756128295, 5182.844514664566, 5191.402988656353, 5214.9478505214465, 5229.92155117666, 5264.63147579681], "value": 3853.8677272013624, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.2067959807426, 723.8118089296781, 759.3659294489102, 810.6311628209165, 824.8432797768427, 12046.457909394076, 12530.561430349928, 12564.874351256485, 12586.811197832028, 14202.218877961708, 13532.120412173203, 13717.45130194791, 13816.723665526684, 13838.308084595781, 13948.511802086929, 683.3986092238848, 885.6944354197824, 888.0364804187432, 888.9822203555925, 890.1543533643065, 868.4702331577764, 892.2727976698969, 894.5616647842576, 894.6421431427416, 896.6413434626137, 921.1387352825096, 921.5346250143668, 926.2913870888775, 927.0775578299567, 930.0467021303184, 907.6142639378238, 914.5107367558325, 916.4592890194783, 919.0901008002097, 920.6041402197053, 673.7641825361134, 675.2538445018233, 675.5541342713834, 677.3159109299594, 678.1590827374021, 13378.197308161542, 13438.0, 13475.595732128051, 13483.66290842727, 13525.797113043312, 12823.935880320632, 12863.099583029192, 12994.0, 13084.934575327157, 13128.86871131286, 9863.950680246624, 9867.96386379427, 10134.797304053951, 10141.0, 10168.847467287997, 3359.781614195094, 3368.747343949189, 3394.304167645627, 3427.537282466885, 3430.828458577061, 44989.0, 45319.32021019687, 45617.0, 48604.27093593599, 48900.99999999964, 10667.413292269, 10739.624113156158, 10888.128949684005, 10926.016658500774, 10980.231383803217, 19503.219871205278, 19643.0, 19755.703664445045, 19838.206471741258, 19850.70223946642, 7106.751263705745, 7154.713811447484, 7169.7849064528145, 7229.2770722928335, 7266.92733072673, 3666.7066634669163, 3691.077230692327, 3717.070732316921, 3727.6272372762505, 3741.345264578688, 3014.8794048238265, 3093.211231136091, 3121.9843900780807, 3126.4059828632944, 3126.8592913318957, 507.93650793650795, 521.4811262793469, 532.2282690099371, 532.2575007864008, 534.8769782949944, 598.6168851934765, 613.5490414545395, 622.7882519943241, 624.8781487609963, 631.6810010944444, 8341.332693384515, 8559.572021398904, 8722.389432739774, 8725.432846864933, 8898.243649289883, 621.1211136242257, 623.9126522286883, 633.47105167185, 635.293064965929, 635.6535688050024, 3899.2786334528205, 3941.4087886816633, 4024.5792462826103, 4094.590540945941, 4136.710430269853, 55588.0, 55828.16257756137, 56253.43746562482, 56454.0, 56749.71625141848, 50708.23937640939, 50828.0, 51508.227376589384, 51876.74061629743, 52135.0, 46944.295835562494, 47023.29465058027, 47611.285830712564, 47945.5205447948, 48590.27114593213, 7553.131389890233, 7604.163542010264, 7698.0762308523335, 7772.339351154989, 7802.843943120993, 31324.843375782973, 31458.37083258276, 31474.842625786725, 31571.842140789147, 31764.04707858768, 37442.0, 41062.79468602638, 41746.58253417548, 41850.37224441575, 42246.7887660572, 10174.13519850821, 10392.42841643717, 10511.211659125749, 10533.262671612914, 10598.470076496298, 10696.679099627023, 10759.30064545802, 10955.287906286067, 11110.61112861046, 11189.384583847966, 10049.397036177852, 10066.295359324777, 10282.177425806067, 10408.427536485264, 10743.301685390425, 10129.746756331151, 10289.9485502572, 10557.9472102639, 10557.9472102639, 11087.0, 10213.08082272599, 10373.0, 10392.844107338246, 10411.168217808174, 10455.268131230741, 8983.416077954913, 9037.728868133967, 9103.726888193365, 9127.908720912706, 9222.95388523053, 8367.497950123012, 8831.91168088311, 8863.556822158736, 8876.51179185151, 8910.910890891268], "value": 6170.856724136033, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 108.0, 115.0, 115.0, 115.0, 109.0, 117.0, 115.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 135.0, 160.0, 218.0, 131.0, 158.0, 158.0, 132.0, 188.0, 150.0], "value": 159.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 172.0, 167.0, 164.0, 164.0, 163.0, 164.0, 165.0, 164.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 76.0, 165.0, 76.0, 75.0, 76.0, 79.0, 161.0, 78.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 168.0, 93.0, 98.0, 93.0, 143.0, 94.0, 93.0, 139.0], "value": 110.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 120.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 69.0, 64.0, 63.0, 65.0, 64.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 81.0, 83.0, 87.0, 83.0, 90.0, 84.0, 137.0, 84.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 141.0, 140.0, 130.0, 147.0, 140.0, 133.0, 136.0, 158.0, 145.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 180.0, 172.0, 175.0, 177.0, 171.0, 172.0, 174.0, 169.0, 169.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 66.0, 67.0, 71.0, 67.0, 69.0, 66.0, 66.0], "value": 67.6, "unit": "score"}]}]} 23:02:00 INFO - Return code: 0 23:02:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:02:00 ERROR - # TBPL SUCCESS # 23:02:00 INFO - Running post-action listener: _resource_record_post_action 23:02:00 INFO - ##### 23:02:00 INFO - ##### Finished run-tests step (success) 23:02:00 INFO - ##### 23:02:00 INFO - Running post-run listener: _resource_record_post_run 23:02:00 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 8192; Write bytes: 531738624; Read time: 112; Write time: 503416 23:02:00 INFO - TinderboxPrint: CPU usage
13.5% 23:02:00 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 112 23:02:00 INFO - TinderboxPrint: I/O write bytes / time
531,738,624 / 503,416 23:02:00 INFO - TinderboxPrint: CPU idle
8,267.4 (86.5%) 23:02:00 INFO - TinderboxPrint: CPU user
1,234.7 (12.9%) 23:02:00 INFO - TinderboxPrint: Swap in / out
0 / 0 23:02:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236265472; Read time: 0; Write time: 307652 23:02:00 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295395328; Read time: 112; Write time: 195764 23:02:00 INFO - Running post-run listener: _upload_blobber_files 23:02:00 INFO - Blob upload gear active. 23:02:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:02:00 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 23:02:00 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'] 23:02:00 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 23:02:01 INFO - (blobuploader) - INFO - Open directory for files ... 23:02:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:02:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:02:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:06 INFO - (blobuploader) - INFO - Done attempting. 23:02:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:02:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:02:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:07 INFO - (blobuploader) - INFO - Done attempting. 23:02:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:02:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:02:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:02:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:02:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:02:07 INFO - (blobuploader) - INFO - Done attempting. 23:02:07 INFO - (blobuploader) - INFO - Iteration through files over. 23:02:07 INFO - Return code: 0 23:02:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:02:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:02:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e995878e1d6d60bd88dc2bd600066c5de053e132f51cab63b395d77d23adfe5f4841234e5780b1e091048bb87c95dca4e4cb2f1108cdfcf367b9f47b135f27e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09cbf018b03f59871e1a1a9d88668929a803bab9e8883178bdb180a33364668bf4fda0e28da5e468f547fbdd133f5f2851c983717ff95afba09305582e9f4ef1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/138700be4241d69505cc51f1fda66fb05761b0df0fb24550f54151c0a7dd6712cab4c5b32270f1d35c12bc160d7582c06a5249f510f559d8580f6d7ed885784b"} 23:02:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:02:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:02:07 INFO - Contents: 23:02:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e995878e1d6d60bd88dc2bd600066c5de053e132f51cab63b395d77d23adfe5f4841234e5780b1e091048bb87c95dca4e4cb2f1108cdfcf367b9f47b135f27e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09cbf018b03f59871e1a1a9d88668929a803bab9e8883178bdb180a33364668bf4fda0e28da5e468f547fbdd133f5f2851c983717ff95afba09305582e9f4ef1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/138700be4241d69505cc51f1fda66fb05761b0df0fb24550f54151c0a7dd6712cab4c5b32270f1d35c12bc160d7582c06a5249f510f559d8580f6d7ed885784b"} 23:02:07 INFO - Running post-run listener: copy_logs_to_upload_dir 23:02:07 INFO - Copying logs to upload dir... 23:02:07 INFO - mkdir: /builds/slave/test/build/upload/logs 23:02:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.488950 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-16 23:02:07.130205) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 23:02:07.133937) ========= 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-1463463327.660310-2054429155 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/0e995878e1d6d60bd88dc2bd600066c5de053e132f51cab63b395d77d23adfe5f4841234e5780b1e091048bb87c95dca4e4cb2f1108cdfcf367b9f47b135f27e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09cbf018b03f59871e1a1a9d88668929a803bab9e8883178bdb180a33364668bf4fda0e28da5e468f547fbdd133f5f2851c983717ff95afba09305582e9f4ef1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/138700be4241d69505cc51f1fda66fb05761b0df0fb24550f54151c0a7dd6712cab4c5b32270f1d35c12bc160d7582c06a5249f510f559d8580f6d7ed885784b"} build_url:https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/BG3sUWRRSSKOWa1BrDtnJg/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/0e995878e1d6d60bd88dc2bd600066c5de053e132f51cab63b395d77d23adfe5f4841234e5780b1e091048bb87c95dca4e4cb2f1108cdfcf367b9f47b135f27e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09cbf018b03f59871e1a1a9d88668929a803bab9e8883178bdb180a33364668bf4fda0e28da5e468f547fbdd133f5f2851c983717ff95afba09305582e9f4ef1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/138700be4241d69505cc51f1fda66fb05761b0df0fb24550f54151c0a7dd6712cab4c5b32270f1d35c12bc160d7582c06a5249f510f559d8580f6d7ed885784b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 23:02:07.163505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:02:07.163851) ========= 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-1463463327.660310-2054429155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 23:02:07.251180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 23:02:07.251946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 23:02:07.252632) ========= ========= Total master_lag: 0.18 =========