builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1463261837.73 results: success (0) buildid: 20160514130834 builduid: 689ff90b8cf74d23b3cfa22bda78770d revision: 403912ca555eb65f814b18ecf38ad8e8e98569f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:17.726674) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:17.727090) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:17.727361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:17.753060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:17.753341) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-14 14:37:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-05-14 14:37:19 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133186 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:17.908394) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:17.908702) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015223 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:17.976953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-14 14:37:17.977327) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 403912ca555eb65f814b18ecf38ad8e8e98569f5 --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 403912ca555eb65f814b18ecf38ad8e8e98569f5 --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=82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-14 14:37:19,575 truncating revision to first 12 chars 2016-05-14 14:37:19,575 Setting DEBUG logging. 2016-05-14 14:37:19,575 attempt 1/10 2016-05-14 14:37:19,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/403912ca555e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 14:37:20,942 unpacking tar archive at: fx-team-403912ca555e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.687272 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-14 14:37:19.680883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:19.681194) ========= script_repo_revision: 403912ca555eb65f814b18ecf38ad8e8e98569f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:19.681599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:19.681867) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 14:37:19.689935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-14 14:37:19.690296) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:37:21 INFO - MultiFileLogger online at 20160514 14:37:21 in /builds/slave/test 14:37:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:37:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:37:21 INFO - {'append_to_log': False, 14:37:21 INFO - 'base_work_dir': '/builds/slave/test', 14:37:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:37:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:37:21 INFO - 'branch': 'Fx-Team-Non-PGO', 14:37:21 INFO - 'buildbot_json_path': 'buildprops.json', 14:37:21 INFO - 'config_files': ('talos/linux_config.py',), 14:37:21 INFO - 'default_actions': ('clobber', 14:37:21 INFO - 'read-buildbot-config', 14:37:21 INFO - 'download-and-extract', 14:37:21 INFO - 'populate-webroot', 14:37:21 INFO - 'create-virtualenv', 14:37:21 INFO - 'install', 14:37:21 INFO - 'run-tests'), 14:37:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:37:21 INFO - 'download_minidump_stackwalk': True, 14:37:21 INFO - 'download_symbols': 'ondemand', 14:37:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:37:21 INFO - 'tooltool.py': '/tools/tooltool.py', 14:37:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:37:21 INFO - '/tools/misc-python/virtualenv.py')}, 14:37:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:37:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:37:21 INFO - 'installer_path': 'installer.exe', 14:37:21 INFO - 'log_level': 'info', 14:37:21 INFO - 'log_name': 'talos', 14:37:21 INFO - 'log_to_console': True, 14:37:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:37:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:37:21 INFO - 'opt_config_files': (), 14:37:21 INFO - 'pip_index': False, 14:37:21 INFO - 'sps_profile': False, 14:37:21 INFO - 'sps_profile_interval': 0, 14:37:21 INFO - 'suite': 'dromaeojs', 14:37:21 INFO - 'system_bits': '32', 14:37:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:37:21 INFO - 'title': 'talos-linux64-ix-066', 14:37:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:37:21 INFO - 'use_talos_json': True, 14:37:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:37:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:37:21 INFO - 'work_dir': 'build'} 14:37:21 INFO - ##### 14:37:21 INFO - ##### Running clobber step. 14:37:21 INFO - ##### 14:37:21 INFO - Running pre-action listener: _resource_record_pre_action 14:37:21 INFO - Running main action method: clobber 14:37:21 INFO - rmtree: /builds/slave/test/build 14:37:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:37:21 INFO - Running post-action listener: _resource_record_post_action 14:37:21 INFO - ##### 14:37:21 INFO - ##### Finished clobber step (success) 14:37:21 INFO - ##### 14:37:21 INFO - ##### 14:37:21 INFO - ##### Running read-buildbot-config step. 14:37:21 INFO - ##### 14:37:21 INFO - Running pre-action listener: _resource_record_pre_action 14:37:21 INFO - Running main action method: read_buildbot_config 14:37:21 INFO - Using buildbot properties: 14:37:21 INFO - { 14:37:21 INFO - "project": "", 14:37:21 INFO - "product": "firefox", 14:37:21 INFO - "script_repo_revision": "production", 14:37:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:37:21 INFO - "repository": "", 14:37:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:37:21 INFO - "buildid": "20160514130834", 14:37:21 INFO - "pgo_build": "False", 14:37:21 INFO - "basedir": "/builds/slave/test", 14:37:21 INFO - "buildnumber": 1743, 14:37:21 INFO - "slavename": "talos-linux64-ix-066", 14:37:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:37:21 INFO - "platform": "ubuntu64_hw", 14:37:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:37:21 INFO - "branch": "fx-team", 14:37:21 INFO - "repo_path": "integration/fx-team", 14:37:21 INFO - "revision": "403912ca555eb65f814b18ecf38ad8e8e98569f5", 14:37:21 INFO - "stage_platform": "linux64", 14:37:21 INFO - "builduid": "689ff90b8cf74d23b3cfa22bda78770d", 14:37:21 INFO - "slavebuilddir": "test" 14:37:21 INFO - } 14:37:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:37:21 INFO - Running post-action listener: _resource_record_post_action 14:37:21 INFO - ##### 14:37:21 INFO - ##### Finished read-buildbot-config step (success) 14:37:21 INFO - ##### 14:37:21 INFO - ##### 14:37:21 INFO - ##### Running download-and-extract step. 14:37:21 INFO - ##### 14:37:21 INFO - Running pre-action listener: _resource_record_pre_action 14:37:21 INFO - Running main action method: download_and_extract 14:37:21 INFO - mkdir: /builds/slave/test/build/tests 14:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:21 INFO - https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:37:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:37:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:37:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:23 INFO - Downloaded 1361 bytes. 14:37:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:37:23 INFO - Using the following test package requirements: 14:37:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:37:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:37:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:37:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:37:23 INFO - u'jsshell-linux-x86_64.zip'], 14:37:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:37:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:37:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:37:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:37:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:37:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:37:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:37:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:23 INFO - https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:25 INFO - Downloaded 22448136 bytes. 14:37:25 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'] 14:37:25 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 14:37:26 INFO - Return code: 0 14:37:26 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 14:37:26 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')]} 14:37:26 INFO - https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:37:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:37:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:37:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:27 INFO - Downloaded 22448136 bytes. 14:37:27 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'] 14:37:27 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 14:37:29 INFO - Return code: 0 14:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:29 INFO - https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:30 INFO - Downloaded 10840194 bytes. 14:37:30 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'] 14:37:30 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 14:37:30 INFO - Return code: 0 14:37:30 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')]} 14:37:30 INFO - https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LeTv27tMT0C5JugUjfJ4og/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 14:37:33 INFO - Downloaded 54729917 bytes. 14:37:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:37:33 INFO - mkdir: /builds/slave/test/properties 14:37:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:37:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:37:33 INFO - Contents: 14:37:33 INFO - build_url:https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:37:34 INFO - Running post-action listener: _resource_record_post_action 14:37:34 INFO - Running post-action listener: set_extra_try_arguments 14:37:34 INFO - ##### 14:37:34 INFO - ##### Finished download-and-extract step (success) 14:37:34 INFO - ##### 14:37:34 INFO - ##### 14:37:34 INFO - ##### Running populate-webroot step. 14:37:34 INFO - ##### 14:37:34 INFO - Running pre-action listener: _resource_record_pre_action 14:37:34 INFO - Running main action method: populate_webroot 14:37:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:37:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:37:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:37:34 INFO - '--tppagecycles', 14:37:34 INFO - '7'], 14:37:34 INFO - 'tests': ['tsvgm']}}, 14:37:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:37:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:37:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:37:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:37:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:34 INFO - 'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:34 INFO - 'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['damp', 'tps']}, 14:37:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:34 INFO - 'tests': ['damp', 'tps']}, 14:37:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['dromaeo_dom']}, 14:37:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:37:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['a11yr', 14:37:34 INFO - 'ts_paint', 14:37:34 INFO - 'tpaint', 14:37:34 INFO - 'sessionrestore', 14:37:34 INFO - 'sessionrestore_no_auto_restore', 14:37:34 INFO - 'tabpaint']}, 14:37:34 INFO - 'other-e10s': {'tests': ['a11yr', 14:37:34 INFO - 'ts_paint', 14:37:34 INFO - 'tpaint', 14:37:34 INFO - 'sessionrestore', 14:37:34 INFO - 'sessionrestore_no_auto_restore', 14:37:34 INFO - 'tabpaint']}, 14:37:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:37:34 INFO - 'ts_paint', 14:37:34 INFO - 'tpaint', 14:37:34 INFO - 'sessionrestore', 14:37:34 INFO - 'sessionrestore_no_auto_restore', 14:37:34 INFO - 'tabpaint']}, 14:37:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:37:34 INFO - 'ts_paint', 14:37:34 INFO - 'tpaint', 14:37:34 INFO - 'sessionrestore', 14:37:34 INFO - 'sessionrestore_no_auto_restore', 14:37:34 INFO - 'tabpaint']}, 14:37:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['a11yr', 14:37:34 INFO - 'ts_paint', 14:37:34 INFO - 'tpaint', 14:37:34 INFO - 'sessionrestore', 14:37:34 INFO - 'sessionrestore_no_auto_restore', 14:37:34 INFO - 'tabpaint']}, 14:37:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['a11yr', 14:37:34 INFO - 'ts_paint', 14:37:34 INFO - 'tpaint', 14:37:34 INFO - 'sessionrestore', 14:37:34 INFO - 'sessionrestore_no_auto_restore', 14:37:34 INFO - 'tabpaint']}, 14:37:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['tsvgx', 14:37:34 INFO - 'tsvgr_opacity', 14:37:34 INFO - 'tart', 14:37:34 INFO - 'tscrollx', 14:37:34 INFO - 'cart']}, 14:37:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:37:34 INFO - 'tsvgr_opacity', 14:37:34 INFO - 'tart', 14:37:34 INFO - 'tscrollx', 14:37:34 INFO - 'cart']}, 14:37:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:34 INFO - 'talos_options': ['--disable-e10s'], 14:37:34 INFO - 'tests': ['tp5o']}, 14:37:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:34 INFO - 'tests': ['tp5o']}, 14:37:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:34 INFO - 'talos_options': ['--disable-e10s', 14:37:34 INFO - '--xperf_path', 14:37:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:34 INFO - 'tests': ['tp5n']}, 14:37:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:34 INFO - 'talos_options': ['--xperf_path', 14:37:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:34 INFO - 'tests': ['tp5n']}}, 14:37:34 INFO - 'talos.zip': {'path': '', 14:37:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:37:34 INFO - Running post-action listener: _resource_record_post_action 14:37:34 INFO - ##### 14:37:34 INFO - ##### Finished populate-webroot step (success) 14:37:34 INFO - ##### 14:37:34 INFO - ##### 14:37:34 INFO - ##### Running create-virtualenv step. 14:37:34 INFO - ##### 14:37:34 INFO - Running pre-action listener: _resource_record_pre_action 14:37:34 INFO - Running main action method: create_virtualenv 14:37:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:37:34 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 14:37:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:37:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:37:34 INFO - Using real prefix '/usr' 14:37:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:37:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:37:36 INFO - Installing pip.................done. 14:37:36 INFO - Return code: 0 14:37:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:36 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 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37:36 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 14:37:36 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 14:37:36 INFO - Using env: {'DISPLAY': ':0', 14:37:36 INFO - 'HOME': '/home/cltbld', 14:37:36 INFO - 'LANG': 'en_US.UTF-8', 14:37:36 INFO - 'LANGUAGE': 'en_US:en', 14:37:36 INFO - 'LOGNAME': 'cltbld', 14:37:36 INFO - 'MAIL': '/var/mail/cltbld', 14:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:36 INFO - 'MOZ_NO_REMOTE': '1', 14:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:36 INFO - 'NO_EM_RESTART': '1', 14:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:36 INFO - 'PWD': '/builds/slave/test', 14:37:36 INFO - 'SHELL': '/bin/bash', 14:37:36 INFO - 'SHLVL': '1', 14:37:36 INFO - 'TERM': 'linux', 14:37:36 INFO - 'TMOUT': '86400', 14:37:36 INFO - 'USER': 'cltbld', 14:37:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:36 INFO - '_': '/tools/buildbot/bin/python'} 14:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:36 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 14:37:36 INFO - Cleaning up... 14:37:36 INFO - Return code: 0 14:37:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:36 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 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37:36 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 14:37:36 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 14:37:36 INFO - Using env: {'DISPLAY': ':0', 14:37:36 INFO - 'HOME': '/home/cltbld', 14:37:36 INFO - 'LANG': 'en_US.UTF-8', 14:37:36 INFO - 'LANGUAGE': 'en_US:en', 14:37:36 INFO - 'LOGNAME': 'cltbld', 14:37:36 INFO - 'MAIL': '/var/mail/cltbld', 14:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:36 INFO - 'MOZ_NO_REMOTE': '1', 14:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:36 INFO - 'NO_EM_RESTART': '1', 14:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:36 INFO - 'PWD': '/builds/slave/test', 14:37:36 INFO - 'SHELL': '/bin/bash', 14:37:36 INFO - 'SHLVL': '1', 14:37:36 INFO - 'TERM': 'linux', 14:37:36 INFO - 'TMOUT': '86400', 14:37:36 INFO - 'USER': 'cltbld', 14:37:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:36 INFO - '_': '/tools/buildbot/bin/python'} 14:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:37 INFO - Downloading/unpacking psutil>=3.1.1 14:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:37:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:39 INFO - Installing collected packages: psutil 14:37:39 INFO - Running setup.py install for psutil 14:37:39 INFO - building 'psutil._psutil_linux' extension 14:37:39 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 14:37:39 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 14:37:39 INFO - building 'psutil._psutil_posix' extension 14:37:39 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 14:37:39 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 14:37:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:39 INFO - Successfully installed psutil 14:37:39 INFO - Cleaning up... 14:37:39 INFO - Return code: 0 14:37:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:37: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 mozsystemmonitor==0.3 14:37:39 INFO - Using env: {'DISPLAY': ':0', 14:37:39 INFO - 'HOME': '/home/cltbld', 14:37:39 INFO - 'LANG': 'en_US.UTF-8', 14:37:39 INFO - 'LANGUAGE': 'en_US:en', 14:37:39 INFO - 'LOGNAME': 'cltbld', 14:37:39 INFO - 'MAIL': '/var/mail/cltbld', 14:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:39 INFO - 'MOZ_NO_REMOTE': '1', 14:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:39 INFO - 'NO_EM_RESTART': '1', 14:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:39 INFO - 'PWD': '/builds/slave/test', 14:37:39 INFO - 'SHELL': '/bin/bash', 14:37:39 INFO - 'SHLVL': '1', 14:37:39 INFO - 'TERM': 'linux', 14:37:39 INFO - 'TMOUT': '86400', 14:37:39 INFO - 'USER': 'cltbld', 14:37:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:39 INFO - '_': '/tools/buildbot/bin/python'} 14:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:37:41 INFO - Installing collected packages: mozsystemmonitor 14:37:41 INFO - Running setup.py install for mozsystemmonitor 14:37:41 INFO - Successfully installed mozsystemmonitor 14:37:41 INFO - Cleaning up... 14:37:41 INFO - Return code: 0 14:37:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:37:41 INFO - Using env: {'DISPLAY': ':0', 14:37:41 INFO - 'HOME': '/home/cltbld', 14:37:41 INFO - 'LANG': 'en_US.UTF-8', 14:37:41 INFO - 'LANGUAGE': 'en_US:en', 14:37:41 INFO - 'LOGNAME': 'cltbld', 14:37:41 INFO - 'MAIL': '/var/mail/cltbld', 14:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:41 INFO - 'MOZ_NO_REMOTE': '1', 14:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:41 INFO - 'NO_EM_RESTART': '1', 14:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:41 INFO - 'PWD': '/builds/slave/test', 14:37:41 INFO - 'SHELL': '/bin/bash', 14:37:41 INFO - 'SHLVL': '1', 14:37:41 INFO - 'TERM': 'linux', 14:37:41 INFO - 'TMOUT': '86400', 14:37:41 INFO - 'USER': 'cltbld', 14:37:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:41 INFO - '_': '/tools/buildbot/bin/python'} 14:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:37:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:37:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:44 INFO - Downloading docopt-0.6.1.tar.gz 14:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:37:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:37:44 INFO - Running setup.py install for blobuploader 14:37:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:37:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:37:44 INFO - Running setup.py install for requests 14:37:45 INFO - Running setup.py install for docopt 14:37:45 INFO - Successfully installed blobuploader requests docopt 14:37:45 INFO - Cleaning up... 14:37:45 INFO - Return code: 0 14:37:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:45 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 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37:45 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 14:37:45 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 14:37:45 INFO - Using env: {'DISPLAY': ':0', 14:37:45 INFO - 'HOME': '/home/cltbld', 14:37:45 INFO - 'LANG': 'en_US.UTF-8', 14:37:45 INFO - 'LANGUAGE': 'en_US:en', 14:37:45 INFO - 'LOGNAME': 'cltbld', 14:37:45 INFO - 'MAIL': '/var/mail/cltbld', 14:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:45 INFO - 'MOZ_NO_REMOTE': '1', 14:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:45 INFO - 'NO_EM_RESTART': '1', 14:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:45 INFO - 'PWD': '/builds/slave/test', 14:37:45 INFO - 'SHELL': '/bin/bash', 14:37:45 INFO - 'SHLVL': '1', 14:37:45 INFO - 'TERM': 'linux', 14:37:45 INFO - 'TMOUT': '86400', 14:37:45 INFO - 'USER': 'cltbld', 14:37:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:45 INFO - '_': '/tools/buildbot/bin/python'} 14:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:45 INFO - Running setup.py (path:/tmp/pip-u070BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:45 INFO - Running setup.py (path:/tmp/pip-l45F3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:45 INFO - Running setup.py (path:/tmp/pip-Yc_IRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:45 INFO - Running setup.py (path:/tmp/pip-uflLrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:45 INFO - Running setup.py (path:/tmp/pip-ybV2KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:45 INFO - Running setup.py (path:/tmp/pip-p4YFFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:46 INFO - Running setup.py (path:/tmp/pip-nX_eyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:46 INFO - Running setup.py (path:/tmp/pip-7Rhuho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:46 INFO - Running setup.py (path:/tmp/pip-3QBsqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:46 INFO - Running setup.py (path:/tmp/pip-5V95n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:46 INFO - Running setup.py (path:/tmp/pip-82pg8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:46 INFO - Running setup.py (path:/tmp/pip-999Slk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:46 INFO - Running setup.py (path:/tmp/pip-LcEKkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:46 INFO - Running setup.py (path:/tmp/pip-rYFdK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:46 INFO - Running setup.py (path:/tmp/pip-dc9ODs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:46 INFO - Running setup.py (path:/tmp/pip-G0TAgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:46 INFO - Running setup.py (path:/tmp/pip-OmV8VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:37:46 INFO - Running setup.py install for manifestparser 14:37:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:37:46 INFO - Running setup.py install for mozcrash 14:37:47 INFO - Running setup.py install for mozdebug 14:37:47 INFO - Running setup.py install for mozdevice 14:37:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Running setup.py install for mozfile 14:37:47 INFO - Running setup.py install for mozhttpd 14:37:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Running setup.py install for mozinfo 14:37:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Running setup.py install for mozInstall 14:37:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Running setup.py install for mozleak 14:37:47 INFO - Running setup.py install for mozlog 14:37:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Running setup.py install for moznetwork 14:37:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:37:47 INFO - Running setup.py install for mozprocess 14:37:48 INFO - Running setup.py install for mozprofile 14:37:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:37:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:37:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:37:48 INFO - Running setup.py install for mozrunner 14:37:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:37:48 INFO - Running setup.py install for mozscreenshot 14:37:48 INFO - Running setup.py install for moztest 14:37:48 INFO - Running setup.py install for mozversion 14:37:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:37:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:37:48 INFO - Cleaning up... 14:37:48 INFO - Return code: 0 14:37:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:48 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 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37:48 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 14:37:48 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 14:37:48 INFO - Using env: {'DISPLAY': ':0', 14:37:48 INFO - 'HOME': '/home/cltbld', 14:37:48 INFO - 'LANG': 'en_US.UTF-8', 14:37:48 INFO - 'LANGUAGE': 'en_US:en', 14:37:48 INFO - 'LOGNAME': 'cltbld', 14:37:48 INFO - 'MAIL': '/var/mail/cltbld', 14:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:48 INFO - 'MOZ_NO_REMOTE': '1', 14:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:48 INFO - 'NO_EM_RESTART': '1', 14:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:48 INFO - 'PWD': '/builds/slave/test', 14:37:48 INFO - 'SHELL': '/bin/bash', 14:37:48 INFO - 'SHLVL': '1', 14:37:48 INFO - 'TERM': 'linux', 14:37:48 INFO - 'TMOUT': '86400', 14:37:48 INFO - 'USER': 'cltbld', 14:37:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:48 INFO - '_': '/tools/buildbot/bin/python'} 14:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:48 INFO - Running setup.py (path:/tmp/pip-iMDstf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:48 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)) 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:48 INFO - Running setup.py (path:/tmp/pip-NjVNp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:48 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)) 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:48 INFO - Running setup.py (path:/tmp/pip-VVsHDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:49 INFO - Running setup.py (path:/tmp/pip-mLCzzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:49 INFO - Running setup.py (path:/tmp/pip-rqz8l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:49 INFO - Running setup.py (path:/tmp/pip-BVoknj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:49 INFO - Running setup.py (path:/tmp/pip-IhavHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:49 INFO - Running setup.py (path:/tmp/pip-6VHziQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:49 INFO - Running setup.py (path:/tmp/pip-feFJie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:49 INFO - Running setup.py (path:/tmp/pip-g7jKBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:49 INFO - Running setup.py (path:/tmp/pip-uNl2ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:49 INFO - Running setup.py (path:/tmp/pip-hhK0K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:49 INFO - Running setup.py (path:/tmp/pip-ZwanyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:49 INFO - Running setup.py (path:/tmp/pip-z6hbUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:49 INFO - Running setup.py (path:/tmp/pip-xOvJjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:49 INFO - Running setup.py (path:/tmp/pip-qgM9DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:49 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)) 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:49 INFO - Running setup.py (path:/tmp/pip-g6xPVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:50 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)) 14:37:50 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)) 14:37:50 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)) 14:37:50 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)) 14:37:50 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)) 14:37:50 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)) 14:37:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:51 INFO - Downloading blessings-1.6.tar.gz 14:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:37:52 INFO - Installing collected packages: blessings 14:37:52 INFO - Running setup.py install for blessings 14:37:52 INFO - Successfully installed blessings 14:37:52 INFO - Cleaning up... 14:37:52 INFO - Return code: 0 14:37:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:37:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:52 INFO - Reading from file tmpfile_stdout 14:37:52 INFO - Current package versions: 14:37:52 INFO - argparse == 1.2.1 14:37:52 INFO - blessings == 1.6 14:37:52 INFO - blobuploader == 1.2.4 14:37:52 INFO - docopt == 0.6.1 14:37:52 INFO - manifestparser == 1.1 14:37:52 INFO - mozInstall == 1.12 14:37:52 INFO - mozcrash == 0.17 14:37:52 INFO - mozdebug == 0.1 14:37:52 INFO - mozdevice == 0.48 14:37:52 INFO - mozfile == 1.2 14:37:52 INFO - mozhttpd == 0.7 14:37:52 INFO - mozinfo == 0.9 14:37:52 INFO - mozleak == 0.1 14:37:52 INFO - mozlog == 3.2 14:37:52 INFO - moznetwork == 0.27 14:37:52 INFO - mozprocess == 0.22 14:37:52 INFO - mozprofile == 0.28 14:37:52 INFO - mozrunner == 6.11 14:37:52 INFO - mozscreenshot == 0.1 14:37:52 INFO - mozsystemmonitor == 0.3 14:37:52 INFO - moztest == 0.7 14:37:52 INFO - mozversion == 1.4 14:37:52 INFO - psutil == 3.1.1 14:37:52 INFO - requests == 1.2.3 14:37:52 INFO - wsgiref == 0.1.2 14:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:52 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 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37:52 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 14:37:52 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 14:37:52 INFO - Using env: {'DISPLAY': ':0', 14:37:52 INFO - 'HOME': '/home/cltbld', 14:37:52 INFO - 'LANG': 'en_US.UTF-8', 14:37:52 INFO - 'LANGUAGE': 'en_US:en', 14:37:52 INFO - 'LOGNAME': 'cltbld', 14:37:52 INFO - 'MAIL': '/var/mail/cltbld', 14:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:52 INFO - 'MOZ_NO_REMOTE': '1', 14:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:52 INFO - 'NO_EM_RESTART': '1', 14:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:52 INFO - 'PWD': '/builds/slave/test', 14:37:52 INFO - 'SHELL': '/bin/bash', 14:37:52 INFO - 'SHLVL': '1', 14:37:52 INFO - 'TERM': 'linux', 14:37:52 INFO - 'TMOUT': '86400', 14:37:52 INFO - 'USER': 'cltbld', 14:37:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:52 INFO - '_': '/tools/buildbot/bin/python'} 14:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 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)) 14:37:52 INFO - Cleaning up... 14:37:52 INFO - Return code: 0 14:37:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:37:52 INFO - Using env: {'DISPLAY': ':0', 14:37:52 INFO - 'HOME': '/home/cltbld', 14:37:52 INFO - 'LANG': 'en_US.UTF-8', 14:37:52 INFO - 'LANGUAGE': 'en_US:en', 14:37:52 INFO - 'LOGNAME': 'cltbld', 14:37:52 INFO - 'MAIL': '/var/mail/cltbld', 14:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:52 INFO - 'MOZ_NO_REMOTE': '1', 14:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:52 INFO - 'NO_EM_RESTART': '1', 14:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:52 INFO - 'PWD': '/builds/slave/test', 14:37:52 INFO - 'SHELL': '/bin/bash', 14:37:52 INFO - 'SHLVL': '1', 14:37:52 INFO - 'TERM': 'linux', 14:37:52 INFO - 'TMOUT': '86400', 14:37:52 INFO - 'USER': 'cltbld', 14:37:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:52 INFO - '_': '/tools/buildbot/bin/python'} 14:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:52 INFO - Downloading/unpacking jsonschema 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:37:54 INFO - Downloading/unpacking functools32 (from jsonschema) 14:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:37:54 INFO - warning: no files found matching '*.txt' 14:37:54 INFO - no previously-included directories found matching 'build' 14:37:54 INFO - no previously-included directories found matching 'dist' 14:37:54 INFO - no previously-included directories found matching '.git*' 14:37:54 INFO - Installing collected packages: jsonschema, functools32 14:37:55 INFO - Running setup.py install for functools32 14:37:55 INFO - warning: no files found matching '*.txt' 14:37:55 INFO - no previously-included directories found matching 'build' 14:37:55 INFO - no previously-included directories found matching 'dist' 14:37:55 INFO - no previously-included directories found matching '.git*' 14:37:55 INFO - Successfully installed jsonschema functools32 14:37:55 INFO - Cleaning up... 14:37:55 INFO - Return code: 0 14:37:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9270c67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2314770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', '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 14:37: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', 'flake8'] in /builds/slave/test/build 14:37: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 flake8 14:37:55 INFO - Using env: {'DISPLAY': ':0', 14:37:55 INFO - 'HOME': '/home/cltbld', 14:37:55 INFO - 'LANG': 'en_US.UTF-8', 14:37:55 INFO - 'LANGUAGE': 'en_US:en', 14:37:55 INFO - 'LOGNAME': 'cltbld', 14:37:55 INFO - 'MAIL': '/var/mail/cltbld', 14:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:55 INFO - 'MOZ_NO_REMOTE': '1', 14:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:55 INFO - 'NO_EM_RESTART': '1', 14:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:55 INFO - 'PWD': '/builds/slave/test', 14:37:55 INFO - 'SHELL': '/bin/bash', 14:37:55 INFO - 'SHLVL': '1', 14:37:55 INFO - 'TERM': 'linux', 14:37:55 INFO - 'TMOUT': '86400', 14:37:55 INFO - 'USER': 'cltbld', 14:37:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:55 INFO - '_': '/tools/buildbot/bin/python'} 14:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:55 INFO - Downloading/unpacking flake8 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:37:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:37:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37: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 14:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:37:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:37:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:37:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:37:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:37:57 INFO - no previously-included directories found matching 'docs/_build' 14:37:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:37:58 INFO - Running setup.py install for pep8 14:37:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:37:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:37:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:37:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:37:58 INFO - no previously-included directories found matching 'docs/_build' 14:37:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:37:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:37:58 INFO - Cleaning up... 14:37:58 INFO - Return code: 0 14:37:58 INFO - Running post-action listener: _resource_record_post_action 14:37:58 INFO - Running post-action listener: _start_resource_monitoring 14:37:58 INFO - Starting resource monitoring. 14:37:58 INFO - ##### 14:37:58 INFO - ##### Finished create-virtualenv step (success) 14:37:58 INFO - ##### 14:37:58 INFO - ##### 14:37:58 INFO - ##### Running install step. 14:37:58 INFO - ##### 14:37:58 INFO - Running pre-action listener: _resource_record_pre_action 14:37:58 INFO - Running main action method: install 14:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:58 INFO - Reading from file tmpfile_stdout 14:37:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:37:58 INFO - Reading from file tmpfile_stdout 14:37:58 INFO - Output received: 14:37:58 INFO - Usage: mozinstall [options] installer 14:37:58 INFO - Options: 14:37:58 INFO - -h, --help show this help message and exit 14:37:58 INFO - -d DEST, --destination=DEST 14:37:58 INFO - Directory to install application into. [default: 14:37:58 INFO - "/builds/slave/test"] 14:37:58 INFO - --app=APP Application being installed. [default: firefox] 14:37:58 INFO - mkdir: /builds/slave/test/build/application 14:37:58 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'] 14:37:58 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 14:38:14 INFO - Reading from file tmpfile_stdout 14:38:14 INFO - Output received: 14:38:14 INFO - /builds/slave/test/build/application/firefox/firefox 14:38:14 INFO - Running post-action listener: _resource_record_post_action 14:38:14 INFO - ##### 14:38:14 INFO - ##### Finished install step (success) 14:38:14 INFO - ##### 14:38:14 INFO - ##### 14:38:14 INFO - ##### Running run-tests step. 14:38:14 INFO - ##### 14:38:14 INFO - Running pre-action listener: _resource_record_pre_action 14:38:14 INFO - Running main action method: run_tests 14:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:38:14 INFO - Python 2.7.3 14:38:14 INFO - Return code: 0 14:38:14 INFO - grabbing minidump binary from tooltool 14:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:14 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 0x23a39c0>, '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 0x23a48c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:38:14 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 14:38:14 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 14:38:14 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 14:38:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:38:14 INFO - Return code: 0 14:38:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:38:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:38:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:38:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:38:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:38:15 INFO - Return code: 0 14:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:38:15 INFO - Using env: {'DISPLAY': ':0', 14:38:15 INFO - 'HOME': '/home/cltbld', 14:38:15 INFO - 'LANG': 'en_US.UTF-8', 14:38:15 INFO - 'LANGUAGE': 'en_US:en', 14:38:15 INFO - 'LOGNAME': 'cltbld', 14:38:15 INFO - 'MAIL': '/var/mail/cltbld', 14:38:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:38:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:15 INFO - 'MOZ_NO_REMOTE': '1', 14:38:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:15 INFO - 'NO_EM_RESTART': '1', 14:38:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:15 INFO - 'PWD': '/builds/slave/test', 14:38:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:38:15 INFO - 'SHELL': '/bin/bash', 14:38:15 INFO - 'SHLVL': '1', 14:38:15 INFO - 'TERM': 'linux', 14:38:15 INFO - 'TMOUT': '86400', 14:38:15 INFO - 'USER': 'cltbld', 14:38:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104', 14:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:15 INFO - '_': '/tools/buildbot/bin/python'} 14:38:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:38:15 INFO - mozversion application_buildid: 20160514130834 14:38:15 INFO - mozversion application_changeset: 403912ca555eb65f814b18ecf38ad8e8e98569f5 14:38:15 INFO - mozversion application_display_name: Nightly 14:38:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:38:15 INFO - mozversion application_name: Firefox 14:38:15 INFO - mozversion application_remotingname: firefox 14:38:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:38:15 INFO - mozversion application_vendor: Mozilla 14:38:15 INFO - mozversion application_version: 49.0a1 14:38:15 INFO - mozversion platform_buildid: 20160514130834 14:38:15 INFO - mozversion platform_changeset: 403912ca555eb65f814b18ecf38ad8e8e98569f5 14:38:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:38:15 INFO - mozversion platform_version: 49.0a1 14:38:15 INFO - using testdate: 1463261895 14:38:15 INFO - actual date: 1463261895 14:38:15 INFO - starting webserver on 'localhost:33400' 14:38:15 INFO - SUITE-START | Running 2 tests 14:38:15 INFO - TEST-START | dromaeo_css 14:38:15 INFO - operating with platform_type : linux_ 14:38:15 INFO - Initialising browser for dromaeo_css test... 14:38:15 INFO - TEST-INFO | started process 16296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFr1Ch/profile http://localhost:33400/getInfo.html) 14:38:20 INFO - PROCESS | 16296 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 14:38:20 INFO - PROCESS | 16296 | __metrics Screen width/height:1600/1200 14:38:20 INFO - PROCESS | 16296 | colorDepth:24 14:38:20 INFO - PROCESS | 16296 | Browser inner width/height: 1024/697 14:38:20 INFO - PROCESS | 16296 | __metrics 14:38:21 ERROR - PROCESS | 16296 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:38:22 INFO - TEST-INFO | 16296: exit 0 14:38:22 INFO - Browser initialized. 14:38:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:38:22 INFO - TEST-INFO | started process 16377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFr1Ch/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:34 INFO - PROCESS | 16377 | RSS: Main: 154906624 14:38:34 INFO - PROCESS | 16377 | 14:39:25 INFO - PROCESS | 16377 | 1463261965026 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] 14:41:37 INFO - PROCESS | 16377 | Cycle 1(1): loaded http://localhost:33400/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33400/tests/dromaeo/cssquery-ext.html) 14:41:39 INFO - PROCESS | 16377 | RSS: Main: 267087872 14:41:39 INFO - PROCESS | 16377 | 14:44:41 INFO - PROCESS | 16377 | Cycle 1(1): loaded http://localhost:33400/tests/dromaeo/cssquery-ext.html (next: http://localhost:33400/tests/dromaeo/cssquery-jquery.html) 14:44:42 INFO - PROCESS | 16377 | RSS: Main: 234037248 14:44:42 INFO - PROCESS | 16377 | 14:47:44 INFO - PROCESS | 16377 | Cycle 1(1): loaded http://localhost:33400/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33400/tests/dromaeo/cssquery-mootools.html) 14:47:44 INFO - PROCESS | 16377 | RSS: Main: 237363200 14:47:44 INFO - PROCESS | 16377 | 14:50:47 INFO - PROCESS | 16377 | Cycle 1(1): loaded http://localhost:33400/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33400/tests/dromaeo/cssquery-prototype.html) 14:50:47 INFO - PROCESS | 16377 | RSS: Main: 240865280 14:50:47 INFO - PROCESS | 16377 | 14:53:50 INFO - PROCESS | 16377 | Cycle 1(1): loaded http://localhost:33400/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33400/tests/dromaeo/cssquery-yui.html) 14:53:51 INFO - PROCESS | 16377 | RSS: Main: 214089728 14:53:51 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | Cycle 1(1): loaded http://localhost:33400/tests/dromaeo/cssquery-yui.html (next: http://localhost:33400/tests/dromaeo/cssquery-dojo.html) 14:56:54 INFO - PROCESS | 16377 | RSS: Main: 272162816 14:56:54 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | __start_tp_report 14:56:54 INFO - PROCESS | 16377 | _x_x_mozilla_page_load 14:56:54 INFO - PROCESS | 16377 | _x_x_mozilla_page_load_details 14:56:54 INFO - PROCESS | 16377 | |i|pagename|runs| 14:56:54 INFO - PROCESS | 16377 | |0;dojo.html;2710.2682275785537;2725.8909643614256;2750.0374868795925;2754.641896553449;2770.3212712885334;4699.90600187996;4738.407699037621;4773.618110551156;4856.6600337976315;4906.803727850886;4773.06925149596;4784.497627749089;4799.088173247081;4801.591864691497;4812.614990800736;4353.346997950309;4400.62594679451;4463.68754187207;4484.349769283452;4600.447946246455;4519.050999290153;4529.04889973106;4548.772561371935;4574.016586433916;4604.769761511911;4332.415123958257;4381.539938306464;4393.450818647669;4425.402570652985;4486.663500237495;4379.64962802975;4390.121975604892;4418.64650827933;4425.181341451842;4452.599266066037;4444.288913773813;4465.196264672358;4465.218586747339;4481.170983368054;4505.098980203972;4552.089582083597;4696;4709.458412282597;4742.928856067162;4791.856244312677;5192.428832828386;5228.215767634847;5240.34495688039;5251.632385733;5255.947440525622;5222.76497557607;5252.684838909639;5257.369115706139;5284.603654725911;5291.3650361956425;4669;4805.231163013901;4815.109204797053;4838.056578967067;4929.309896614441;5306.893862122736;5354.678719276778;5367.060764366221;5373.892522149613;5380.112281473513;5099.515546023122;5107.233914912793;5113.769880355393;5159.819406320836;5174.870628234325;5065.088284108896;5134.897302053938;5170.069387510284;5179.948200518022;5269.789208431696;5175.741212939338;5176.689398636094;5180.145276029413;5181.222816577543;5201.271821944931;5151.6136289778415;5156.303898973591;5162.767675454614;5162.9741851291255;5206.140986737221;4171.70798044134;4207.558206388347;4208.915821683549;4257.3613957905945;4378.956210437918;3769.1142581493327;3780.5652349980105;3791.1280405506886;3809.7523660961947;3848.5958974307855;4492.101579684077;4494.07871386365;4499.6400287976885;4537.77311134442;4541.3869127668;5056.772445239973;5132.666376685578;5180.870478238075;5185.818496352609;5189.792408303701;4460.50934397216;4483.3723278741;4503.842365517191;4519.367288579601;4521.796519156645;4633.62930965522;4664.416947881515;4667.579917807346;4673.228917228687;4717.033008233304;4759.714417134983;4859.805607775649;4956.801727930842;4959.256111583291;4989.0770207511005;5135.717535535581;5149.150390185578;5179.30079439286;5180.145276029563;5229.92155117666;4896.534829191363;4901.852944411673;4911.778969946289;4911.852644420673;4958.57852082577;4934.654574179916;4993.775280112476;5063.113955057924;5082.923756143735;5087.186050231945;5145.434002259673;5177.585793136464;5178.223266510054;5179.715115668524;5220.425753167073;5024.874378140576;5042.067217564762;5043.5712964398435;5049.7727602257255;5094.312267843794;4857.222844344888;4959.876003099951;4985.202367621163;4994.650374473752;5030.748462576929;4955.529224723646;4994.1759609663995;5036.269740887624;5037.622178336566;5039.0929632666475;5059.822906198266;5065.4174769900455;5067.898642027065;5068.417132029716;5106.157484015244;4820.566149046603;4913.06651736169;4957.801687932442;4984.925226121683;5000.474950130184 14:56:54 INFO - PROCESS | 16377 | |1;ext.html;556.4213218253017;603.1917230910578;606.9393060693928;607.9361667024965;612.2866860107973;42319.36520952184;43695.78152109239;43822.12355752883;47650.76174619131;47670;43543.34684979728;44114.55885441144;44217.77891110548;44308.55691443085;44364.334534982;8018.077921039082;8155.266026057654;8162.9183708162755;8163.38774591908;8166.305864001537;7930.088039875402;8016.238457346542;8020.037595488549;8025.157358477334;8054.23484768946;8015.158408367125;8065.2741253287195;8065.6773729050765;8070.757877263692;8073.677052917906;8031.277185053344;8053.43625946187;8064.31453326468;8069.838603227902;8075.071366792835;7946.324562412202;8019.318357939582;8019.839603207962;8023.197680231989;8025.197480251928;39643.40534891979;39905.60094399048;40011;40055.59944400548;40095.39856902149;3225.483922572401;3396.8980930572125;3403.2002479417315;3408.522806807049;3505.6669616386403;29893.25266868324;30838;31053;31174;31960.041198764073;3497.352989696889;3551.271989242199;3607.2304043685585;3621.2002654490325;3632.0556655269556;260335;260948;262546;262674;264046;56825.14762278569;56970.43029569651;57231.71384143052;57409;57415;36099.4585081224;37040.444393334124;37084.81457592695;38687.226255474736;60596.39403605996;16610.169491525376;16774.49676509707;16784.58038549046;16794.076325801954;16805.663886722195;12524.81212781809;12570.245785252913;12587.370631468573;12594.559190428292;12604.558840440724;19770.209191632173;20066.398008059783;20110.59778804445;20127.698084528743;20128.19487220524;7301.269873012656;7354.800661712173;7420.443466740016;7424.814379640444;7449.88825167623;861.9482831030158;961.2502248246379;983.6409710455775;988.1748739802346;990.8117457683018;27930.44139117247;28630.85684571564;29110.867837379556;29175.562366564518;29193;1029.6396261308482;1042.4058286776617;1063.5905176506947;1066.1417558865032;1084.1868598551087;15083.622909427133;15623.60940976462;15641.217939102999;15697.474124630962;15901.284442199898;401550;406538;406718;407070;407092;53418;54075.188872166946;54075.188872166946;54159.18761218585;54217;1173.7417768091007;1253.9059570532247;1282.1473719976111;1285.389440015985;1294.6504443800122;28821.27946801347;29886.85056574703;29993.4001319968;30120.84939575288;30463.847680761453;44801;45040.324395133444;45302.32046519239;45345;45368;241302;241399;241447;241448;242227;23229;23471.061157554188;23477;23657;23694.170704025277;43921;44096;44243.33634995413;45137.09725805531;45338.546614533436;36851;38038.61961380351;38123.61876381201;38186.80906595449;38450.807745961094;37316.6268337324;38746.6125338743;40428.59571404366;42066.57933420627;42626.147477049664;38661.6133838658;38894.2221155581;38928;39396;39474.210515788945;33402.33195336031;34218.657813421545;34458.82770586131;35265.47101793424;35372;26142.34644133912;26545.7345426551;26739.197824065308;26951.326216844736;27099.59350609782 14:56:54 INFO - PROCESS | 16377 | |2;jquery.html;379.51232666024157;387.6511139974023;390.9179072394797;401.43999121225875;406.27074401449397;16379.262933168005;18129.184186711598;18897.90551047246;18928.242870285172;18936.715949260753;17440.215190316434;17644.294228230854;18292.45122646323;18295.176717047732;18610;5123.154679477891;5254.316938797951;5267.55225805807;5268.473152684739;5312.973435132819;5405.162199859028;5694.715264236792;5713.771449142029;5721.971390143043;5732.598718089715;5616.550675945935;5683.488486036256;5687.090065589507;5691.430856914296;5700.087985922253;5546.223528705985;5628.971855140698;5647.8588035299035;5682.687452190128;5682.715864206793;4851.927221091686;5206.453322401169;5464.098423760075;5499.175123731432;5500.614956953015;12659.36703164838;12829.87170128296;12969.351532423341;12978.415971281314;15822.60443488922;2011.517235863397;2033.1968872295508;2156.8166705829867;2220.500387412835;2251.5046689728397;9111.179993800524;9287.628494860197;9416.858747118798;9676.612935482572;9864.112229899272;1658.6931417687767;1700.6768713944311;1735.0630659443884;1772.7784026996626;1787.6335351252962;52615.73692131515;65113.02330465094;66218.66890665564;71064.6446767768;75353;10283.434411107311;10503.894961050291;10535.315204511682;10543.736406589896;10789.946050269698;13036.934815326053;13759.17444953306;13765.449382024606;13814.723705525834;14635;6857.485688573377;7267.527610705393;7580.317771400601;7773;8007.119216886138;7689.615519224017;7709.884351734729;7747.690092396241;7844.568548729761;7866.134725180225;4560.635149188057;4578.862634120982;4612.077584483117;4634.030537021752;4676.438827340741;1904.3144467991513;1959.6864501679663;1972.3491247888448;1986.4636548131923;1991.442396129086;823.8887750153773;871.3073106880046;925.2135684667978;1032.808930347888;1047.2407504559133;17258.568535786704;17277.65444691099;17313.65372692539;17605.7359139613;17863.106844657716;886.4504007515382;888.7778055486128;901.4726385064679;936.5832204668857;960.7454024683465;9752.804943901225;9923;10145.03622155894;10148.949255253825;10201.693949181536;374314;376309;381758;382768;383141;73596;76991.23008769841;77128;87903;91204.54397728102;921.2952091649893;927.8840144981878;939.2720641502754;955.9426434413957;974.8537719342297;16029.438969636007;16370.508884733477;16475.505734827973;16603.501894943172;16795;38607.42088868613;38997.805010974764;39704.404433932934;39797.80101099476;39840.40239396354;54852.451475486334;55293;56307.71846140743;57083.71458142683;57177;7510;7852.646630901509;7914.089879663912;7918.3665306776475;7927.088384835818;10290;11420.657380278604;11451.713707157387;11656.941715291368;12003.579874704343;9996.400215987063;10096.747581310527;10152.086312231935;10258.794824103625;10306.433146177033;9958.800823983625;9981.351212171186;10270.794584108127;10344.896551034393;10380.429076400871;10142.49287535635;10275.383476991405;10421.895781042092;10436.217283703601;10587.470626468492;6848.9657551711925;7157.212706602374;7362.190159082389;7364.410847132323;7880.605969701377;10035.498225088862;10441.425721585385;10512.894871051498;10639.840402393815;10685.145188384755 14:56:54 INFO - PROCESS | 16377 | |3;mootools.html;1303.3743802974566;1500.1449173970836;1526.030970333838;1675.597856514437;1853.2494339792388;7146.8570628587395;7798.415118866086;7960.999999999993;7971.36229101672;8161.347092232622;7920.80197995049;8095.554744489051;8097.433179677425;8098.0282366116;8117.63470643821;1962.8233458988689;2198.8790616516085;2261.163369553268;2296.4258935266225;2319.141917490531;2315.0276883708884;2334.7315058768204;2336.6611841283;2339.894704738282;2340.1224540797202;2325.7790509901533;2348.6946696929463;2348.9530209395803;2350.1891847312736;2350.2244259394442;1888.8583356248269;2128.457243402938;2196.736391632998;2197.9450513737124;2245.259064508716;2272.0570963050313;2274.3859158027403;2288.187693368847;2289.3589794857467;2291.8510296830655;8427.410081294312;8489.872651910226;8495.915040849573;8497;8500;4820.204666230068;4939.185034469308;4940.184869496528;4951.158303088484;4953.4798846121;3094.891678791254;3118.4075025745037;3178.7933784303946;3230.612326520809;3235.288236587947;897.1925267259453;919.9218066464292;933.9252859771202;950.1780959470078;957.3585697582637;11756.823647645293;11770.234934729215;11803.704907377298;11808.409579521076;11821.468033938407;4416.4037854889175;4516.751578663205;4583.54164583539;4602.171609110393;4613.815447382134;9891.406515609087;9903.752406189758;9903.851442228372;9925.15636170919;9930.106290433896;4932.7286999215385;4973.676711013773;5008.248762685626;5010.824621138243;5011.398632164163;4012.759234445884;4354.129174165117;4484.910301793946;4508.368828364031;4575.862724118282;3771.321162190777;3903.33643280643;3929.76421414716;3942.1130245695063;4025.5571887092397;1263.7725209462385;1285.6271681212531;1285.993570032144;1298.4741179822188;1299.2009913902882;655.3479288108363;805.5609692717483;808.0626473290954;820.1470470710394;824.6866190847439;5423.457654234624;5462.3445186577865;5639.43605639441;5659.858503537363;5704.543636509069;415.5844155844156;419.645399637306;425.33859847936753;425.9744415335028;941.7598512379436;3620.6922411594783;3819.5989421110385;3838.673712734449;3860.2086572253183;3877.8254978526033;10094.192464602815;10350.741231469123;10404.739881502872;10444.268901176845;10445.947770261251;10103.696889093339;10241.692749217535;10325.986432645712;10332.121769649664;10336.741581460374;7558.99999999989;7564.4704870659625;7701.768946931601;7709.38324934004;7712.074551053909;5445.809396671098;5463.153211252262;5588.077967135378;5673.687947162781;5698.0598201296325;9062.728118156467;9451.621935122517;9460.195883349992;9460.479673618018;9473.526323683926;9114.40756350835;9363.344565880323;9373.437593744397;9593.856092158763;9597.088276613711;6212.192414986023;6288.968555157195;6585.374389432996;6768.424683901727;6904.861902762017;7929.920700793149;8163.632636531252;8226.794330141554;8237.135100814328;8242.423030387816;7102.112235970504;7255.854882902418;7312.817179570553;7415.036045314075;7426.665800039119;7125;7139.82150446243;7168.103987001625;7169.092100299961;7273.236310187354;6626.867462650624;6728.663566821541;6731;6731.293214212437;6732.124823772878;4794.736289504111;4810.783514741775;4811.711297322172;4845.442774081026;4924.089043526959;4891.853244402673;4976.975115124401;4992.750362481789;4998.050370429607;5093.974530127326 14:56:54 INFO - PROCESS | 16377 | |4;prototype.html;309.71506214282863;317.7664416653759;320.4328338840251;321.1329410591403;321.65422171166;4766.261229509427;4852.5147485251455;4858.611311095113;4863.392075990501;4872.537108974641;4770.260609605508;4785.545373189541;4806;4817.6634332348785;4818.542238487347;3652.2330310634734;3741;3758.0792705786985;3834.21398613285;3854.2098869731776;3811.3520701480675;3837.616238376168;3848.7690738555634;3849.2878817418728;3853.2293541291715;3608.9819550902207;3810.371288737355;3817.179306449113;3827.4067519534515;3827.6220560598163;3692.556893172823;3817.351050321438;3827.617238276178;3828.617138286177;3840.6927445804267;3375.966240337614;3389.86440542378;3392.9660703392897;3396.7961922284744;3416.350893330259;4626.629869610423;4641.141388843075;4646.256598944186;4656.837010704609;4660.324252983332;4262.488501379854;4377.277749171383;4383.298672212462;4385.386045953569;4403.273459879116;4987.925181122286;5026.623003274733;5055.823046193365;5089.440161582223;5091.261767043795;3701.444783282502;3713.1088538750773;3714.0900479382453;3714.9628503715157;3721.423179407196;5127.230915362688;5181.611379146541;5255.474452554714;5260.105782017066;5263.131583288791;3746.981265093657;3790.8248442982763;3790.8673196438544;3794.962050379516;3815.465834783133;3820.2550502651716;3838.865639702597;3842.1355195080882;3842.558105817811;3866.3427217373114;4298.226319262562;4305.0627217752135;4310.396544483775;4332.133573285356;4338.3080598566585;4900.8774780630765;4988.483119400814;5018.347614810052;5044.1677123274985;5063.518965698327;1322.0481253497467;1323.6823162441137;1327.8340207474066;1330.9001824863174;1333.2333908002938;869.8869147010848;872.8079822439054;897.8428774964356;906.3881879731155;909.1544863277215;4377.365282034088;4400.295952647625;4504.8423305184815;4515.548445155524;4535.659825513099;5174.8873992091885;5175.45657705943;5184.196449550326;5224.764885580158;5239.397469291081;4294.506131794821;4492.707973981681;4508.165989291926;4510.14307281622;4540.909181816345;2748.1480740970364;2763.6872485569193;2785.846778427206;2788.721127887195;2806.733360330765;5012.348394708664;5015.673981191211;5024.773885175176;5026.773795179226;5031.823886163967;5065.442801291855;5303.231031500488;5355.30381050461;5377.381601115843;5390.191471279261;4965.255211718271;4979.850604481871;4983.277424773388;5001.174806157016;5002.599792016557;5234.18870075139;5235.790568377222;5251.6323857331145;5277.551408130352;5281.339832520935;4906.043321552405;5183.377994640668;5188.247704082812;5188.922166167435;5202.687838729688;5026.461636873356;5027.371578552681;5039.933627212825;5046.29351890743;5047.167217409234;3678.926421471502;3686.723495737777;3695.5380577427823;3699.1689113888797;3701.592824789217;5120.155174396183;5226.764795584132;5245.134552798898;5245.265662807134;5305.257263982969;4990.625703072212;5028.673136246132;5074.919283093914;5088.974555127201;5091.389033316026;5056.469070747518;5057.848264552069;5066.240063990431;5068.6705364152685;5076.746162691925;4794.352762377174;4846.5638092571835;4975.253711943237;5007.84976450707;5015.64890457679;4980.726060066731;5061.621038112082;5096.821611243588;5124.7950081996305;5141.5860638323265;4957.82647607332;4958.570300552631;4997.425296090851;5001.799928002984;5013.899722005613 14:56:54 INFO - PROCESS | 16377 | |5;yui.html;661.2659947458322;713.8393861381193;759.6251329096708;771.5717776633969;800.8358286551257;12196.14626976112;12818.166819156771;12926.870731292684;13086.345682715873;13557.898525728528;12736.681582960431;12829.935850320735;12881.162724422906;12900.80648790269;12939.741205175891;672.9966350168266;859.7034023261965;860.9096044915287;866.2982983783124;883.8850949376572;876.8158686675806;879.2043200903192;882.7837179890904;886.1448702002566;886.9866951995725;929.0384452092086;933.4259430450259;934.7055677461611;935.1863878425779;936.0265324063;709.2765379313098;709.5352544083634;709.815447983528;726.4551586310267;917.4632839788732;657.9374959378852;659.9406053455212;673.2493270003911;681.2710399872138;683.2620769568854;13072.477100916047;13094.214347139203;13096.803547946789;13106.541271055466;13126.01554883378;12008.339541325224;12250.387480626023;12372.072094592851;12599.236106945034;12754;11435.59975400857;11462.312261264351;11497.540098396054;11499.597514086967;11548.53805847765;4129.876103716893;4185.434966279544;4190.392393103013;4229.936550951738;4308.31067029277;45793.5420645796;45824.770876145405;45903;45989.5401045992;45994;9462.858057129148;9856.162226210852;9872.901270987199;9897.554610042565;9948.900510994943;15981.840181598267;16015.119168445848;16016.919915400349;16035.518934431986;16144.596385090466;6731.697073631698;6739.629320387426;6755.864882702318;6765.357291057342;6944;3849.287881741887;3856.73002889795;3900.7464514806447;3913.8238779255003;3950.249452603996;2886.1774394297527;2948.660903996068;2984.030190188154;2984.612000439929;2985;536.2599612534677;539.4120408754477;543.1987817968544;551.8510002299357;563.808305176242;479.13755240567536;581.9447152520504;585.4789237578558;586.8532965889128;600.8738164985315;7434.516756410816;7516.210797866145;7569.394448444111;7600.80997975055;7732.149463559004;505.56016265848945;530.7982966472715;560.8766071464353;567.9801206957819;585.844751140948;3628.1836586768295;3646.9817650911577;3672.6327367263593;3677.2461645362637;3751.4935483709896;59432.40567594269;59936;60397;60706.69646651739;61043.08435373473;51189;52628.73685631624;52874;52874.73562632239;54689;47558.762206189436;48178.518214817406;50066;50414.495855041714;50925.745371272904;6753.932460675331;6830.521863469509;7021.1574611047;7031.613261270474;7089.184743754534;32197.839010804797;32284.677153228167;32349.67650323561;32744.508832367057;33040;39958.60041399549;42255.56316586714;43126.35310470408;43740.84461976107;44147;8181.509109453452;8350.87473687883;8412.411131220755;8599.656013759379;8752.606132723915;9588.808223835345;9831.213502919893;9967.700968970943;10001.199904007517;10110.19118470506;9711.417314961125;9730.12428881404;9875.604975800887;9879.20966322678;10043;9512.051209583462;9578.13796758295;9660.275479338938;9700.708978730649;9788.412695238309;8721.345899057724;8848.557572121239;8968.775780605276;9363.531823408939;9408.388454750419;7156.821079473055;7160.749373771893;7509.249075092447;7682.270184332479;7800.102988156435;8057.516549006844;8152;8274.669013239403;8291.378146639147;8419.494830310201 14:56:54 INFO - PROCESS | 16377 | __end_tp_report 14:56:54 INFO - PROCESS | 16377 | __start_cc_report 14:56:54 INFO - PROCESS | 16377 | _x_x_mozilla_cycle_collect,1062 14:56:54 INFO - PROCESS | 16377 | __end_cc_report 14:56:54 INFO - PROCESS | 16377 | __startTimestamp1463263014421__endTimestamp 14:56:54 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | ------- Summary: start ------- 14:56:54 INFO - PROCESS | 16377 | Number of tests: 6 14:56:54 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | [#0] dojo.html Cycles:165 Average:4780.80 Median:4913.07 stddev:504.31 (10.3%) stddev-sans-first:478.98 14:56:54 INFO - PROCESS | 16377 | Values: 2710.3 2725.9 2750.0 2754.6 2770.3 4699.9 4738.4 4773.6 4856.7 4906.8 4773.1 4784.5 4799.1 4801.6 4812.6 4353.3 4400.6 4463.7 4484.3 4600.4 4519.1 4529.0 4548.8 4574.0 4604.8 4332.4 4381.5 4393.5 4425.4 4486.7 4379.6 4390.1 4418.6 4425.2 4452.6 4444.3 4465.2 4465.2 4481.2 4505.1 4552.1 4696.0 4709.5 4742.9 4791.9 5192.4 5228.2 5240.3 5251.6 5255.9 5222.8 5252.7 5257.4 5284.6 5291.4 4669.0 4805.2 4815.1 4838.1 4929.3 5306.9 5354.7 5367.1 5373.9 5380.1 5099.5 5107.2 5113.8 5159.8 5174.9 5065.1 5134.9 5170.1 5179.9 5269.8 5175.7 5176.7 5180.1 5181.2 5201.3 5151.6 5156.3 5162.8 5163.0 5206.1 4171.7 4207.6 4208.9 4257.4 4379.0 3769.1 3780.6 3791.1 3809.8 3848.6 4492.1 4494.1 4499.6 4537.8 4541.4 5056.8 5132.7 5180.9 5185.8 5189.8 4460.5 4483.4 4503.8 4519.4 4521.8 4633.6 4664.4 4667.6 4673.2 4717.0 4759.7 4859.8 4956.8 4959.3 4989.1 5135.7 5149.2 5179.3 5180.1 5229.9 4896.5 4901.9 4911.8 4911.9 4958.6 4934.7 4993.8 5063.1 5082.9 5087.2 5145.4 5177.6 5178.2 5179.7 5220.4 5024.9 5042.1 5043.6 5049.8 5094.3 4857.2 4959.9 4985.2 4994.7 5030.7 4955.5 4994.2 5036.3 5037.6 5039.1 5059.8 5065.4 5067.9 5068.4 5106.2 4820.6 4913.1 4957.8 4984.9 5000.5 14:56:54 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | [#1] ext.html Cycles:180 Average:47122.73 Median:38716.92 stddev:81986.03 (211.8%) stddev-sans-first:82141.47 14:56:54 INFO - PROCESS | 16377 | Values: 556.4 603.2 606.9 607.9 612.3 42319.4 43695.8 43822.1 47650.8 47670.0 43543.3 44114.6 44217.8 44308.6 44364.3 8018.1 8155.3 8162.9 8163.4 8166.3 7930.1 8016.2 8020.0 8025.2 8054.2 8015.2 8065.3 8065.7 8070.8 8073.7 8031.3 8053.4 8064.3 8069.8 8075.1 7946.3 8019.3 8019.8 8023.2 8025.2 39643.4 39905.6 40011.0 40055.6 40095.4 3225.5 3396.9 3403.2 3408.5 3505.7 29893.3 30838.0 31053.0 31174.0 31960.0 3497.4 3551.3 3607.2 3621.2 3632.1 260335.0 260948.0 262546.0 262674.0 264046.0 56825.1 56970.4 57231.7 57409.0 57415.0 36099.5 37040.4 37084.8 38687.2 60596.4 16610.2 16774.5 16784.6 16794.1 16805.7 12524.8 12570.2 12587.4 12594.6 12604.6 19770.2 20066.4 20110.6 20127.7 20128.2 7301.3 7354.8 7420.4 7424.8 7449.9 861.9 961.3 983.6 988.2 990.8 27930.4 28630.9 29110.9 29175.6 29193.0 1029.6 1042.4 1063.6 1066.1 1084.2 15083.6 15623.6 15641.2 15697.5 15901.3 401550.0 406538.0 406718.0 407070.0 407092.0 53418.0 54075.2 54075.2 54159.2 54217.0 1173.7 1253.9 1282.1 1285.4 1294.7 28821.3 29886.9 29993.4 30120.8 30463.8 44801.0 45040.3 45302.3 45345.0 45368.0 241302.0 241399.0 241447.0 241448.0 242227.0 23229.0 23471.1 23477.0 23657.0 23694.2 43921.0 44096.0 44243.3 45137.1 45338.5 36851.0 38038.6 38123.6 38186.8 38450.8 37316.6 38746.6 40428.6 42066.6 42626.1 38661.6 38894.2 38928.0 39396.0 39474.2 33402.3 34218.7 34458.8 35265.5 35372.0 26142.3 26545.7 26739.2 26951.3 27099.6 14:56:54 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | [#2] jquery.html Cycles:180 Average:24285.09 Median:403.86 stddev:62891.64 (15572.8%) stddev-sans-first:63042.46 14:56:54 INFO - PROCESS | 16377 | Values: 379.5 387.7 390.9 401.4 406.3 16379.3 18129.2 18897.9 18928.2 18936.7 17440.2 17644.3 18292.5 18295.2 18610.0 5123.2 5254.3 5267.6 5268.5 5313.0 5405.2 5694.7 5713.8 5722.0 5732.6 5616.6 5683.5 5687.1 5691.4 5700.1 5546.2 5629.0 5647.9 5682.7 5682.7 4851.9 5206.5 5464.1 5499.2 5500.6 12659.4 12829.9 12969.4 12978.4 15822.6 2011.5 2033.2 2156.8 2220.5 2251.5 9111.2 9287.6 9416.9 9676.6 9864.1 1658.7 1700.7 1735.1 1772.8 1787.6 52615.7 65113.0 66218.7 71064.6 75353.0 10283.4 10503.9 10535.3 10543.7 10789.9 13036.9 13759.2 13765.4 13814.7 14635.0 6857.5 7267.5 7580.3 7773.0 8007.1 7689.6 7709.9 7747.7 7844.6 7866.1 4560.6 4578.9 4612.1 4634.0 4676.4 1904.3 1959.7 1972.3 1986.5 1991.4 823.9 871.3 925.2 1032.8 1047.2 17258.6 17277.7 17313.7 17605.7 17863.1 886.5 888.8 901.5 936.6 960.7 9752.8 9923.0 10145.0 10148.9 10201.7 374314.0 376309.0 381758.0 382768.0 383141.0 73596.0 76991.2 77128.0 87903.0 91204.5 921.3 927.9 939.3 955.9 974.9 16029.4 16370.5 16475.5 16603.5 16795.0 38607.4 38997.8 39704.4 39797.8 39840.4 54852.5 55293.0 56307.7 57083.7 57177.0 7510.0 7852.6 7914.1 7918.4 7927.1 10290.0 11420.7 11451.7 11656.9 12003.6 9996.4 10096.7 10152.1 10258.8 10306.4 9958.8 9981.4 10270.8 10344.9 10380.4 10142.5 10275.4 10421.9 10436.2 10587.5 6849.0 7157.2 7362.2 7364.4 7880.6 10035.5 10441.4 10512.9 10639.8 10685.1 14:56:54 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | [#3] mootools.html Cycles:180 Average:5447.88 Median:4963.58 stddev:3104.44 (62.5%) stddev-sans-first:3097.52 14:56:54 INFO - PROCESS | 16377 | Values: 1303.4 1500.1 1526.0 1675.6 1853.2 7146.9 7798.4 7961.0 7971.4 8161.3 7920.8 8095.6 8097.4 8098.0 8117.6 1962.8 2198.9 2261.2 2296.4 2319.1 2315.0 2334.7 2336.7 2339.9 2340.1 2325.8 2348.7 2349.0 2350.2 2350.2 1888.9 2128.5 2196.7 2197.9 2245.3 2272.1 2274.4 2288.2 2289.4 2291.9 8427.4 8489.9 8495.9 8497.0 8500.0 4820.2 4939.2 4940.2 4951.2 4953.5 3094.9 3118.4 3178.8 3230.6 3235.3 897.2 919.9 933.9 950.2 957.4 11756.8 11770.2 11803.7 11808.4 11821.5 4416.4 4516.8 4583.5 4602.2 4613.8 9891.4 9903.8 9903.9 9925.2 9930.1 4932.7 4973.7 5008.2 5010.8 5011.4 4012.8 4354.1 4484.9 4508.4 4575.9 3771.3 3903.3 3929.8 3942.1 4025.6 1263.8 1285.6 1286.0 1298.5 1299.2 655.3 805.6 808.1 820.1 824.7 5423.5 5462.3 5639.4 5659.9 5704.5 415.6 419.6 425.3 426.0 941.8 3620.7 3819.6 3838.7 3860.2 3877.8 10094.2 10350.7 10404.7 10444.3 10445.9 10103.7 10241.7 10326.0 10332.1 10336.7 7559.0 7564.5 7701.8 7709.4 7712.1 5445.8 5463.2 5588.1 5673.7 5698.1 9062.7 9451.6 9460.2 9460.5 9473.5 9114.4 9363.3 9373.4 9593.9 9597.1 6212.2 6289.0 6585.4 6768.4 6904.9 7929.9 8163.6 8226.8 8237.1 8242.4 7102.1 7255.9 7312.8 7415.0 7426.7 7125.0 7139.8 7168.1 7169.1 7273.2 6626.9 6728.7 6731.0 6731.3 6732.1 4794.7 4810.8 4811.7 4845.4 4924.1 4891.9 4977.0 4992.8 4998.1 5094.0 14:56:54 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | [#4] prototype.html Cycles:180 Average:4232.92 Median:4818.10 stddev:1212.61 (25.2%) stddev-sans-first:1179.71 14:56:54 INFO - PROCESS | 16377 | Values: 309.7 317.8 320.4 321.1 321.7 4766.3 4852.5 4858.6 4863.4 4872.5 4770.3 4785.5 4806.0 4817.7 4818.5 3652.2 3741.0 3758.1 3834.2 3854.2 3811.4 3837.6 3848.8 3849.3 3853.2 3609.0 3810.4 3817.2 3827.4 3827.6 3692.6 3817.4 3827.6 3828.6 3840.7 3376.0 3389.9 3393.0 3396.8 3416.4 4626.6 4641.1 4646.3 4656.8 4660.3 4262.5 4377.3 4383.3 4385.4 4403.3 4987.9 5026.6 5055.8 5089.4 5091.3 3701.4 3713.1 3714.1 3715.0 3721.4 5127.2 5181.6 5255.5 5260.1 5263.1 3747.0 3790.8 3790.9 3795.0 3815.5 3820.3 3838.9 3842.1 3842.6 3866.3 4298.2 4305.1 4310.4 4332.1 4338.3 4900.9 4988.5 5018.3 5044.2 5063.5 1322.0 1323.7 1327.8 1330.9 1333.2 869.9 872.8 897.8 906.4 909.2 4377.4 4400.3 4504.8 4515.5 4535.7 5174.9 5175.5 5184.2 5224.8 5239.4 4294.5 4492.7 4508.2 4510.1 4540.9 2748.1 2763.7 2785.8 2788.7 2806.7 5012.3 5015.7 5024.8 5026.8 5031.8 5065.4 5303.2 5355.3 5377.4 5390.2 4965.3 4979.9 4983.3 5001.2 5002.6 5234.2 5235.8 5251.6 5277.6 5281.3 4906.0 5183.4 5188.2 5188.9 5202.7 5026.5 5027.4 5039.9 5046.3 5047.2 3678.9 3686.7 3695.5 3699.2 3701.6 5120.2 5226.8 5245.1 5245.3 5305.3 4990.6 5028.7 5074.9 5089.0 5091.4 5056.5 5057.8 5066.2 5068.7 5076.7 4794.4 4846.6 4975.3 5007.8 5015.6 4980.7 5061.6 5096.8 5124.8 5141.6 4957.8 4958.6 4997.4 5001.8 5013.9 14:56:54 INFO - PROCESS | 16377 | 14:56:54 INFO - PROCESS | 16377 | [#5] yui.html Cycles:180 Average:13260.88 Median:586.35 stddev:16248.39 (2771.1%) stddev-sans-first:16266.43 14:56:54 INFO - PROCESS | 16377 | Values: 661.3 713.8 759.6 771.6 800.8 12196.1 12818.2 12926.9 13086.3 13557.9 12736.7 12829.9 12881.2 12900.8 12939.7 673.0 859.7 860.9 866.3 883.9 876.8 879.2 882.8 886.1 887.0 929.0 933.4 934.7 935.2 936.0 709.3 709.5 709.8 726.5 917.5 657.9 659.9 673.2 681.3 683.3 13072.5 13094.2 13096.8 13106.5 13126.0 12008.3 12250.4 12372.1 12599.2 12754.0 11435.6 11462.3 11497.5 11499.6 11548.5 4129.9 4185.4 4190.4 4229.9 4308.3 45793.5 45824.8 45903.0 45989.5 45994.0 9462.9 9856.2 9872.9 9897.6 9948.9 15981.8 16015.1 16016.9 16035.5 16144.6 6731.7 6739.6 6755.9 6765.4 6944.0 3849.3 3856.7 3900.7 3913.8 3950.2 2886.2 2948.7 2984.0 2984.6 2985.0 536.3 539.4 543.2 551.9 563.8 479.1 581.9 585.5 586.9 600.9 7434.5 7516.2 7569.4 7600.8 7732.1 505.6 530.8 560.9 568.0 585.8 3628.2 3647.0 3672.6 3677.2 3751.5 59432.4 59936.0 60397.0 60706.7 61043.1 51189.0 52628.7 52874.0 52874.7 54689.0 47558.8 48178.5 50066.0 50414.5 50925.7 6753.9 6830.5 7021.2 7031.6 7089.2 32197.8 32284.7 32349.7 32744.5 33040.0 39958.6 42255.6 43126.4 43740.8 44147.0 8181.5 8350.9 8412.4 8599.7 8752.6 9588.8 9831.2 9967.7 10001.2 10110.2 9711.4 9730.1 9875.6 9879.2 10043.0 9512.1 9578.1 9660.3 9700.7 9788.4 8721.3 8848.6 8968.8 9363.5 9408.4 7156.8 7160.7 7509.2 7682.3 7800.1 8057.5 8152.0 8274.7 8291.4 8419.5 14:56:54 INFO - PROCESS | 16377 | -------- Summary: end -------- 14:56:54 INFO - PROCESS | 16377 | 14:56:55 INFO - TEST-INFO | 16377: exit 0 14:56:55 INFO - TEST-OK | dromaeo_css | took 1119711ms 14:56:55 INFO - TEST-START | kraken 14:56:55 INFO - operating with platform_type : linux_ 14:56:55 INFO - Initialising browser for kraken test... 14:56:55 INFO - TEST-INFO | started process 16553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIG5PpB/profile http://localhost:33400/getInfo.html) 14:56:59 INFO - PROCESS | 16553 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 14:56:59 INFO - PROCESS | 16553 | __metrics Screen width/height:1600/1200 14:56:59 INFO - PROCESS | 16553 | colorDepth:24 14:56:59 INFO - PROCESS | 16553 | Browser inner width/height: 1024/697 14:56:59 INFO - PROCESS | 16553 | __metrics 14:57:00 ERROR - PROCESS | 16553 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:57:01 INFO - TEST-INFO | 16553: exit 0 14:57:01 INFO - Browser initialized. 14:57:01 INFO - Running cycle 1/1 for kraken test... 14:57:01 INFO - TEST-INFO | started process 16634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIG5PpB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:13 INFO - PROCESS | 16634 | RSS: Main: 154398720 14:57:13 INFO - PROCESS | 16634 | 14:57:16 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33400/tests/kraken/driver.html?testName=audio-beat-detection) 14:57:17 INFO - PROCESS | 16634 | RSS: Main: 210100224 14:57:17 INFO - PROCESS | 16634 | 14:57:20 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33400/tests/kraken/driver.html?testName=audio-dft) 14:57:21 INFO - PROCESS | 16634 | RSS: Main: 197959680 14:57:21 INFO - PROCESS | 16634 | 14:57:24 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33400/tests/kraken/driver.html?testName=audio-fft) 14:57:25 INFO - PROCESS | 16634 | RSS: Main: 266928128 14:57:25 INFO - PROCESS | 16634 | 14:57:27 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33400/tests/kraken/driver.html?testName=audio-oscillator) 14:57:27 INFO - PROCESS | 16634 | RSS: Main: 175181824 14:57:27 INFO - PROCESS | 16634 | 14:57:30 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33400/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:57:30 INFO - PROCESS | 16634 | RSS: Main: 179957760 14:57:30 INFO - PROCESS | 16634 | 14:57:34 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33400/tests/kraken/driver.html?testName=imaging-darkroom) 14:57:34 INFO - PROCESS | 16634 | RSS: Main: 215851008 14:57:34 INFO - PROCESS | 16634 | 14:57:38 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33400/tests/kraken/driver.html?testName=imaging-desaturate) 14:57:39 INFO - PROCESS | 16634 | RSS: Main: 214839296 14:57:39 INFO - PROCESS | 16634 | 14:57:42 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33400/tests/kraken/driver.html?testName=json-parse-financial) 14:57:42 INFO - PROCESS | 16634 | RSS: Main: 215207936 14:57:42 INFO - PROCESS | 16634 | 14:57:44 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33400/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:57:45 INFO - PROCESS | 16634 | RSS: Main: 208728064 14:57:45 INFO - PROCESS | 16634 | 14:57:47 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33400/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:57:47 INFO - PROCESS | 16634 | RSS: Main: 211374080 14:57:47 INFO - PROCESS | 16634 | 14:57:49 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33400/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:57:50 INFO - PROCESS | 16634 | RSS: Main: 214298624 14:57:50 INFO - PROCESS | 16634 | 14:57:53 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:57:54 INFO - PROCESS | 16634 | RSS: Main: 216702976 14:57:54 INFO - PROCESS | 16634 | 14:57:57 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:57:57 INFO - PROCESS | 16634 | RSS: Main: 217468928 14:57:57 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | Cycle 1(1): loaded http://localhost:33400/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33400/tests/kraken/driver.html?testName=ai-astar) 14:57:59 INFO - PROCESS | 16634 | RSS: Main: 263962624 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | __start_tp_report 14:57:59 INFO - PROCESS | 16634 | _x_x_mozilla_page_load 14:57:59 INFO - PROCESS | 16634 | _x_x_mozilla_page_load_details 14:57:59 INFO - PROCESS | 16634 | |i|pagename|runs| 14:57:59 INFO - PROCESS | 16634 | |0;ai-astar;113;110;113;115;112;113;113;113;114;113 14:57:59 INFO - PROCESS | 16634 | |1;audio-beat-detection;162;138;151;219;133;156;152;131;182;137 14:57:59 INFO - PROCESS | 16634 | |2;audio-dft;161;160;163;162;161;162;161;161;161;162 14:57:59 INFO - PROCESS | 16634 | |3;audio-fft;77;75;75;156;75;74;75;74;131;75 14:57:59 INFO - PROCESS | 16634 | |4;audio-oscillator;92;92;148;92;92;92;124;92;93;123 14:57:59 INFO - PROCESS | 16634 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;116;117 14:57:59 INFO - PROCESS | 16634 | |6;imaging-darkroom;147;148;147;148;147;147;147;147;146;146 14:57:59 INFO - PROCESS | 16634 | |7;imaging-desaturate;95;94;94;95;94;94;95;94;94;94 14:57:59 INFO - PROCESS | 16634 | |8;json-parse-financial;62;63;62;63;63;62;63;62;62;62 14:57:59 INFO - PROCESS | 16634 | |9;json-stringify-tinderbox;65;64;64;63;65;64;64;64;63;64 14:57:59 INFO - PROCESS | 16634 | |10;stanford-crypto-aes;81;83;84;85;85;82;82;82;139;82 14:57:59 INFO - PROCESS | 16634 | |11;stanford-crypto-ccm;133;139;135;135;143;128;127;141;147;134 14:57:59 INFO - PROCESS | 16634 | |12;stanford-crypto-pbkdf2;174;170;168;175;168;167;168;167;168;170 14:57:59 INFO - PROCESS | 16634 | |13;stanford-crypto-sha256-iterative;68;66;70;69;66;67;66;67;65;68 14:57:59 INFO - PROCESS | 16634 | __end_tp_report 14:57:59 INFO - PROCESS | 16634 | __start_cc_report 14:57:59 INFO - PROCESS | 16634 | _x_x_mozilla_cycle_collect,2101 14:57:59 INFO - PROCESS | 16634 | __end_cc_report 14:57:59 INFO - PROCESS | 16634 | __startTimestamp1463263079761__endTimestamp 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | ------- Summary: start ------- 14:57:59 INFO - PROCESS | 16634 | Number of tests: 14 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.29 (1.1%) stddev-sans-first:1.36 14:57:59 INFO - PROCESS | 16634 | Values: 113.0 110.0 113.0 115.0 112.0 113.0 113.0 113.0 114.0 113.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#1] audio-beat-detection Cycles:10 Average:156.10 Median:154.00 stddev:27.00 (17.5%) stddev-sans-first:28.55 14:57:59 INFO - PROCESS | 16634 | Values: 162.0 138.0 151.0 219.0 133.0 156.0 152.0 131.0 182.0 137.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 14:57:59 INFO - PROCESS | 16634 | Values: 161.0 160.0 163.0 162.0 161.0 162.0 161.0 161.0 161.0 162.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#3] audio-fft Cycles:10 Average:88.70 Median:75.00 stddev:29.49 (39.3%) stddev-sans-first:30.97 14:57:59 INFO - PROCESS | 16634 | Values: 77.0 75.0 75.0 156.0 75.0 74.0 75.0 74.0 131.0 75.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:92.00 stddev:20.23 (22.0%) stddev-sans-first:20.98 14:57:59 INFO - PROCESS | 16634 | Values: 92.0 92.0 148.0 92.0 92.0 92.0 124.0 92.0 93.0 123.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:57:59 INFO - PROCESS | 16634 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 14:57:59 INFO - PROCESS | 16634 | Values: 147.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 146.0 146.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:57:59 INFO - PROCESS | 16634 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:57:59 INFO - PROCESS | 16634 | Values: 62.0 63.0 62.0 63.0 63.0 62.0 63.0 62.0 62.0 62.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 14:57:59 INFO - PROCESS | 16634 | Values: 65.0 64.0 64.0 63.0 65.0 64.0 64.0 64.0 63.0 64.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:82.50 stddev:17.80 (21.6%) stddev-sans-first:18.67 14:57:59 INFO - PROCESS | 16634 | Values: 81.0 83.0 84.0 85.0 85.0 82.0 82.0 82.0 139.0 82.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:137.00 stddev:6.36 (4.6%) stddev-sans-first:6.64 14:57:59 INFO - PROCESS | 16634 | Values: 133.0 139.0 135.0 135.0 143.0 128.0 127.0 141.0 147.0 134.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:169.00 stddev:2.84 (1.7%) stddev-sans-first:2.50 14:57:59 INFO - PROCESS | 16634 | Values: 174.0 170.0 168.0 175.0 168.0 167.0 168.0 167.0 168.0 170.0 14:57:59 INFO - PROCESS | 16634 | 14:57:59 INFO - PROCESS | 16634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.55 (2.3%) stddev-sans-first:1.62 14:57:59 INFO - PROCESS | 16634 | Values: 68.0 66.0 70.0 69.0 66.0 67.0 66.0 67.0 65.0 68.0 14:57:59 INFO - PROCESS | 16634 | -------- Summary: end -------- 14:57:59 INFO - PROCESS | 16634 | 14:58:00 INFO - TEST-INFO | 16634: exit 0 14:58:00 INFO - TEST-OK | kraken | took 65624ms 14:58:00 INFO - SUITE-END | took 1185s 14:58:00 INFO - Completed test suite (00:19:45) 14:58:00 INFO - javascript benchmark 14:58:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2710.2682275785537, 2725.8909643614256, 2750.0374868795925, 2754.641896553449, 2770.3212712885334, 4699.90600187996, 4738.407699037621, 4773.618110551156, 4856.6600337976315, 4906.803727850886, 4773.06925149596, 4784.497627749089, 4799.088173247081, 4801.591864691497, 4812.614990800736, 4353.346997950309, 4400.62594679451, 4463.68754187207, 4484.349769283452, 4600.447946246455, 4519.050999290153, 4529.04889973106, 4548.772561371935, 4574.016586433916, 4604.769761511911, 4332.415123958257, 4381.539938306464, 4393.450818647669, 4425.402570652985, 4486.663500237495, 4379.64962802975, 4390.121975604892, 4418.64650827933, 4425.181341451842, 4452.599266066037, 4444.288913773813, 4465.196264672358, 4465.218586747339, 4481.170983368054, 4505.098980203972, 4552.089582083597, 4696.0, 4709.458412282597, 4742.928856067162, 4791.856244312677, 5192.428832828386, 5228.215767634847, 5240.34495688039, 5251.632385733, 5255.947440525622, 5222.76497557607, 5252.684838909639, 5257.369115706139, 5284.603654725911, 5291.3650361956425, 4669.0, 4805.231163013901, 4815.109204797053, 4838.056578967067, 4929.309896614441, 5306.893862122736, 5354.678719276778, 5367.060764366221, 5373.892522149613, 5380.112281473513, 5099.515546023122, 5107.233914912793, 5113.769880355393, 5159.819406320836, 5174.870628234325, 5065.088284108896, 5134.897302053938, 5170.069387510284, 5179.948200518022, 5269.789208431696, 5175.741212939338, 5176.689398636094, 5180.145276029413, 5181.222816577543, 5201.271821944931, 5151.6136289778415, 5156.303898973591, 5162.767675454614, 5162.9741851291255, 5206.140986737221, 4171.70798044134, 4207.558206388347, 4208.915821683549, 4257.3613957905945, 4378.956210437918, 3769.1142581493327, 3780.5652349980105, 3791.1280405506886, 3809.7523660961947, 3848.5958974307855, 4492.101579684077, 4494.07871386365, 4499.6400287976885, 4537.77311134442, 4541.3869127668, 5056.772445239973, 5132.666376685578, 5180.870478238075, 5185.818496352609, 5189.792408303701, 4460.50934397216, 4483.3723278741, 4503.842365517191, 4519.367288579601, 4521.796519156645, 4633.62930965522, 4664.416947881515, 4667.579917807346, 4673.228917228687, 4717.033008233304, 4759.714417134983, 4859.805607775649, 4956.801727930842, 4959.256111583291, 4989.0770207511005, 5135.717535535581, 5149.150390185578, 5179.30079439286, 5180.145276029563, 5229.92155117666, 4896.534829191363, 4901.852944411673, 4911.778969946289, 4911.852644420673, 4958.57852082577, 4934.654574179916, 4993.775280112476, 5063.113955057924, 5082.923756143735, 5087.186050231945, 5145.434002259673, 5177.585793136464, 5178.223266510054, 5179.715115668524, 5220.425753167073, 5024.874378140576, 5042.067217564762, 5043.5712964398435, 5049.7727602257255, 5094.312267843794, 4857.222844344888, 4959.876003099951, 4985.202367621163, 4994.650374473752, 5030.748462576929, 4955.529224723646, 4994.1759609663995, 5036.269740887624, 5037.622178336566, 5039.0929632666475, 5059.822906198266, 5065.4174769900455, 5067.898642027065, 5068.417132029716, 5106.157484015244, 4820.566149046603, 4913.06651736169, 4957.801687932442, 4984.925226121683, 5000.474950130184], "value": 4748.821929429218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.4213218253017, 603.1917230910578, 606.9393060693928, 607.9361667024965, 612.2866860107973, 42319.36520952184, 43695.78152109239, 43822.12355752883, 47650.76174619131, 47670.0, 43543.34684979728, 44114.55885441144, 44217.77891110548, 44308.55691443085, 44364.334534982, 8018.077921039082, 8155.266026057654, 8162.9183708162755, 8163.38774591908, 8166.305864001537, 7930.088039875402, 8016.238457346542, 8020.037595488549, 8025.157358477334, 8054.23484768946, 8015.158408367125, 8065.2741253287195, 8065.6773729050765, 8070.757877263692, 8073.677052917906, 8031.277185053344, 8053.43625946187, 8064.31453326468, 8069.838603227902, 8075.071366792835, 7946.324562412202, 8019.318357939582, 8019.839603207962, 8023.197680231989, 8025.197480251928, 39643.40534891979, 39905.60094399048, 40011.0, 40055.59944400548, 40095.39856902149, 3225.483922572401, 3396.8980930572125, 3403.2002479417315, 3408.522806807049, 3505.6669616386403, 29893.25266868324, 30838.0, 31053.0, 31174.0, 31960.041198764073, 3497.352989696889, 3551.271989242199, 3607.2304043685585, 3621.2002654490325, 3632.0556655269556, 260335.0, 260948.0, 262546.0, 262674.0, 264046.0, 56825.14762278569, 56970.43029569651, 57231.71384143052, 57409.0, 57415.0, 36099.4585081224, 37040.444393334124, 37084.81457592695, 38687.226255474736, 60596.39403605996, 16610.169491525376, 16774.49676509707, 16784.58038549046, 16794.076325801954, 16805.663886722195, 12524.81212781809, 12570.245785252913, 12587.370631468573, 12594.559190428292, 12604.558840440724, 19770.209191632173, 20066.398008059783, 20110.59778804445, 20127.698084528743, 20128.19487220524, 7301.269873012656, 7354.800661712173, 7420.443466740016, 7424.814379640444, 7449.88825167623, 861.9482831030158, 961.2502248246379, 983.6409710455775, 988.1748739802346, 990.8117457683018, 27930.44139117247, 28630.85684571564, 29110.867837379556, 29175.562366564518, 29193.0, 1029.6396261308482, 1042.4058286776617, 1063.5905176506947, 1066.1417558865032, 1084.1868598551087, 15083.622909427133, 15623.60940976462, 15641.217939102999, 15697.474124630962, 15901.284442199898, 401550.0, 406538.0, 406718.0, 407070.0, 407092.0, 53418.0, 54075.188872166946, 54075.188872166946, 54159.18761218585, 54217.0, 1173.7417768091007, 1253.9059570532247, 1282.1473719976111, 1285.389440015985, 1294.6504443800122, 28821.27946801347, 29886.85056574703, 29993.4001319968, 30120.84939575288, 30463.847680761453, 44801.0, 45040.324395133444, 45302.32046519239, 45345.0, 45368.0, 241302.0, 241399.0, 241447.0, 241448.0, 242227.0, 23229.0, 23471.061157554188, 23477.0, 23657.0, 23694.170704025277, 43921.0, 44096.0, 44243.33634995413, 45137.09725805531, 45338.546614533436, 36851.0, 38038.61961380351, 38123.61876381201, 38186.80906595449, 38450.807745961094, 37316.6268337324, 38746.6125338743, 40428.59571404366, 42066.57933420627, 42626.147477049664, 38661.6133838658, 38894.2221155581, 38928.0, 39396.0, 39474.210515788945, 33402.33195336031, 34218.657813421545, 34458.82770586131, 35265.47101793424, 35372.0, 26142.34644133912, 26545.7345426551, 26739.197824065308, 26951.326216844736, 27099.59350609782], "value": 18297.104852904275, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.51232666024157, 387.6511139974023, 390.9179072394797, 401.43999121225875, 406.27074401449397, 16379.262933168005, 18129.184186711598, 18897.90551047246, 18928.242870285172, 18936.715949260753, 17440.215190316434, 17644.294228230854, 18292.45122646323, 18295.176717047732, 18610.0, 5123.154679477891, 5254.316938797951, 5267.55225805807, 5268.473152684739, 5312.973435132819, 5405.162199859028, 5694.715264236792, 5713.771449142029, 5721.971390143043, 5732.598718089715, 5616.550675945935, 5683.488486036256, 5687.090065589507, 5691.430856914296, 5700.087985922253, 5546.223528705985, 5628.971855140698, 5647.8588035299035, 5682.687452190128, 5682.715864206793, 4851.927221091686, 5206.453322401169, 5464.098423760075, 5499.175123731432, 5500.614956953015, 12659.36703164838, 12829.87170128296, 12969.351532423341, 12978.415971281314, 15822.60443488922, 2011.517235863397, 2033.1968872295508, 2156.8166705829867, 2220.500387412835, 2251.5046689728397, 9111.179993800524, 9287.628494860197, 9416.858747118798, 9676.612935482572, 9864.112229899272, 1658.6931417687767, 1700.6768713944311, 1735.0630659443884, 1772.7784026996626, 1787.6335351252962, 52615.73692131515, 65113.02330465094, 66218.66890665564, 71064.6446767768, 75353.0, 10283.434411107311, 10503.894961050291, 10535.315204511682, 10543.736406589896, 10789.946050269698, 13036.934815326053, 13759.17444953306, 13765.449382024606, 13814.723705525834, 14635.0, 6857.485688573377, 7267.527610705393, 7580.317771400601, 7773.0, 8007.119216886138, 7689.615519224017, 7709.884351734729, 7747.690092396241, 7844.568548729761, 7866.134725180225, 4560.635149188057, 4578.862634120982, 4612.077584483117, 4634.030537021752, 4676.438827340741, 1904.3144467991513, 1959.6864501679663, 1972.3491247888448, 1986.4636548131923, 1991.442396129086, 823.8887750153773, 871.3073106880046, 925.2135684667978, 1032.808930347888, 1047.2407504559133, 17258.568535786704, 17277.65444691099, 17313.65372692539, 17605.7359139613, 17863.106844657716, 886.4504007515382, 888.7778055486128, 901.4726385064679, 936.5832204668857, 960.7454024683465, 9752.804943901225, 9923.0, 10145.03622155894, 10148.949255253825, 10201.693949181536, 374314.0, 376309.0, 381758.0, 382768.0, 383141.0, 73596.0, 76991.23008769841, 77128.0, 87903.0, 91204.54397728102, 921.2952091649893, 927.8840144981878, 939.2720641502754, 955.9426434413957, 974.8537719342297, 16029.438969636007, 16370.508884733477, 16475.505734827973, 16603.501894943172, 16795.0, 38607.42088868613, 38997.805010974764, 39704.404433932934, 39797.80101099476, 39840.40239396354, 54852.451475486334, 55293.0, 56307.71846140743, 57083.71458142683, 57177.0, 7510.0, 7852.646630901509, 7914.089879663912, 7918.3665306776475, 7927.088384835818, 10290.0, 11420.657380278604, 11451.713707157387, 11656.941715291368, 12003.579874704343, 9996.400215987063, 10096.747581310527, 10152.086312231935, 10258.794824103625, 10306.433146177033, 9958.800823983625, 9981.351212171186, 10270.794584108127, 10344.896551034393, 10380.429076400871, 10142.49287535635, 10275.383476991405, 10421.895781042092, 10436.217283703601, 10587.470626468492, 6848.9657551711925, 7157.212706602374, 7362.190159082389, 7364.410847132323, 7880.605969701377, 10035.498225088862, 10441.425721585385, 10512.894871051498, 10639.840402393815, 10685.145188384755], "value": 8393.829125463015, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.3743802974566, 1500.1449173970836, 1526.030970333838, 1675.597856514437, 1853.2494339792388, 7146.8570628587395, 7798.415118866086, 7960.999999999993, 7971.36229101672, 8161.347092232622, 7920.80197995049, 8095.554744489051, 8097.433179677425, 8098.0282366116, 8117.63470643821, 1962.8233458988689, 2198.8790616516085, 2261.163369553268, 2296.4258935266225, 2319.141917490531, 2315.0276883708884, 2334.7315058768204, 2336.6611841283, 2339.894704738282, 2340.1224540797202, 2325.7790509901533, 2348.6946696929463, 2348.9530209395803, 2350.1891847312736, 2350.2244259394442, 1888.8583356248269, 2128.457243402938, 2196.736391632998, 2197.9450513737124, 2245.259064508716, 2272.0570963050313, 2274.3859158027403, 2288.187693368847, 2289.3589794857467, 2291.8510296830655, 8427.410081294312, 8489.872651910226, 8495.915040849573, 8497.0, 8500.0, 4820.204666230068, 4939.185034469308, 4940.184869496528, 4951.158303088484, 4953.4798846121, 3094.891678791254, 3118.4075025745037, 3178.7933784303946, 3230.612326520809, 3235.288236587947, 897.1925267259453, 919.9218066464292, 933.9252859771202, 950.1780959470078, 957.3585697582637, 11756.823647645293, 11770.234934729215, 11803.704907377298, 11808.409579521076, 11821.468033938407, 4416.4037854889175, 4516.751578663205, 4583.54164583539, 4602.171609110393, 4613.815447382134, 9891.406515609087, 9903.752406189758, 9903.851442228372, 9925.15636170919, 9930.106290433896, 4932.7286999215385, 4973.676711013773, 5008.248762685626, 5010.824621138243, 5011.398632164163, 4012.759234445884, 4354.129174165117, 4484.910301793946, 4508.368828364031, 4575.862724118282, 3771.321162190777, 3903.33643280643, 3929.76421414716, 3942.1130245695063, 4025.5571887092397, 1263.7725209462385, 1285.6271681212531, 1285.993570032144, 1298.4741179822188, 1299.2009913902882, 655.3479288108363, 805.5609692717483, 808.0626473290954, 820.1470470710394, 824.6866190847439, 5423.457654234624, 5462.3445186577865, 5639.43605639441, 5659.858503537363, 5704.543636509069, 415.5844155844156, 419.645399637306, 425.33859847936753, 425.9744415335028, 941.7598512379436, 3620.6922411594783, 3819.5989421110385, 3838.673712734449, 3860.2086572253183, 3877.8254978526033, 10094.192464602815, 10350.741231469123, 10404.739881502872, 10444.268901176845, 10445.947770261251, 10103.696889093339, 10241.692749217535, 10325.986432645712, 10332.121769649664, 10336.741581460374, 7558.99999999989, 7564.4704870659625, 7701.768946931601, 7709.38324934004, 7712.074551053909, 5445.809396671098, 5463.153211252262, 5588.077967135378, 5673.687947162781, 5698.0598201296325, 9062.728118156467, 9451.621935122517, 9460.195883349992, 9460.479673618018, 9473.526323683926, 9114.40756350835, 9363.344565880323, 9373.437593744397, 9593.856092158763, 9597.088276613711, 6212.192414986023, 6288.968555157195, 6585.374389432996, 6768.424683901727, 6904.861902762017, 7929.920700793149, 8163.632636531252, 8226.794330141554, 8237.135100814328, 8242.423030387816, 7102.112235970504, 7255.854882902418, 7312.817179570553, 7415.036045314075, 7426.665800039119, 7125.0, 7139.82150446243, 7168.103987001625, 7169.092100299961, 7273.236310187354, 6626.867462650624, 6728.663566821541, 6731.0, 6731.293214212437, 6732.124823772878, 4794.736289504111, 4810.783514741775, 4811.711297322172, 4845.442774081026, 4924.089043526959, 4891.853244402673, 4976.975115124401, 4992.750362481789, 4998.050370429607, 5093.974530127326], "value": 4305.486932125097, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.71506214282863, 317.7664416653759, 320.4328338840251, 321.1329410591403, 321.65422171166, 4766.261229509427, 4852.5147485251455, 4858.611311095113, 4863.392075990501, 4872.537108974641, 4770.260609605508, 4785.545373189541, 4806.0, 4817.6634332348785, 4818.542238487347, 3652.2330310634734, 3741.0, 3758.0792705786985, 3834.21398613285, 3854.2098869731776, 3811.3520701480675, 3837.616238376168, 3848.7690738555634, 3849.2878817418728, 3853.2293541291715, 3608.9819550902207, 3810.371288737355, 3817.179306449113, 3827.4067519534515, 3827.6220560598163, 3692.556893172823, 3817.351050321438, 3827.617238276178, 3828.617138286177, 3840.6927445804267, 3375.966240337614, 3389.86440542378, 3392.9660703392897, 3396.7961922284744, 3416.350893330259, 4626.629869610423, 4641.141388843075, 4646.256598944186, 4656.837010704609, 4660.324252983332, 4262.488501379854, 4377.277749171383, 4383.298672212462, 4385.386045953569, 4403.273459879116, 4987.925181122286, 5026.623003274733, 5055.823046193365, 5089.440161582223, 5091.261767043795, 3701.444783282502, 3713.1088538750773, 3714.0900479382453, 3714.9628503715157, 3721.423179407196, 5127.230915362688, 5181.611379146541, 5255.474452554714, 5260.105782017066, 5263.131583288791, 3746.981265093657, 3790.8248442982763, 3790.8673196438544, 3794.962050379516, 3815.465834783133, 3820.2550502651716, 3838.865639702597, 3842.1355195080882, 3842.558105817811, 3866.3427217373114, 4298.226319262562, 4305.0627217752135, 4310.396544483775, 4332.133573285356, 4338.3080598566585, 4900.8774780630765, 4988.483119400814, 5018.347614810052, 5044.1677123274985, 5063.518965698327, 1322.0481253497467, 1323.6823162441137, 1327.8340207474066, 1330.9001824863174, 1333.2333908002938, 869.8869147010848, 872.8079822439054, 897.8428774964356, 906.3881879731155, 909.1544863277215, 4377.365282034088, 4400.295952647625, 4504.8423305184815, 4515.548445155524, 4535.659825513099, 5174.8873992091885, 5175.45657705943, 5184.196449550326, 5224.764885580158, 5239.397469291081, 4294.506131794821, 4492.707973981681, 4508.165989291926, 4510.14307281622, 4540.909181816345, 2748.1480740970364, 2763.6872485569193, 2785.846778427206, 2788.721127887195, 2806.733360330765, 5012.348394708664, 5015.673981191211, 5024.773885175176, 5026.773795179226, 5031.823886163967, 5065.442801291855, 5303.231031500488, 5355.30381050461, 5377.381601115843, 5390.191471279261, 4965.255211718271, 4979.850604481871, 4983.277424773388, 5001.174806157016, 5002.599792016557, 5234.18870075139, 5235.790568377222, 5251.6323857331145, 5277.551408130352, 5281.339832520935, 4906.043321552405, 5183.377994640668, 5188.247704082812, 5188.922166167435, 5202.687838729688, 5026.461636873356, 5027.371578552681, 5039.933627212825, 5046.29351890743, 5047.167217409234, 3678.926421471502, 3686.723495737777, 3695.5380577427823, 3699.1689113888797, 3701.592824789217, 5120.155174396183, 5226.764795584132, 5245.134552798898, 5245.265662807134, 5305.257263982969, 4990.625703072212, 5028.673136246132, 5074.919283093914, 5088.974555127201, 5091.389033316026, 5056.469070747518, 5057.848264552069, 5066.240063990431, 5068.6705364152685, 5076.746162691925, 4794.352762377174, 4846.5638092571835, 4975.253711943237, 5007.84976450707, 5015.64890457679, 4980.726060066731, 5061.621038112082, 5096.821611243588, 5124.7950081996305, 5141.5860638323265, 4957.82647607332, 4958.570300552631, 4997.425296090851, 5001.799928002984, 5013.899722005613], "value": 3854.0339154722706, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.2659947458322, 713.8393861381193, 759.6251329096708, 771.5717776633969, 800.8358286551257, 12196.14626976112, 12818.166819156771, 12926.870731292684, 13086.345682715873, 13557.898525728528, 12736.681582960431, 12829.935850320735, 12881.162724422906, 12900.80648790269, 12939.741205175891, 672.9966350168266, 859.7034023261965, 860.9096044915287, 866.2982983783124, 883.8850949376572, 876.8158686675806, 879.2043200903192, 882.7837179890904, 886.1448702002566, 886.9866951995725, 929.0384452092086, 933.4259430450259, 934.7055677461611, 935.1863878425779, 936.0265324063, 709.2765379313098, 709.5352544083634, 709.815447983528, 726.4551586310267, 917.4632839788732, 657.9374959378852, 659.9406053455212, 673.2493270003911, 681.2710399872138, 683.2620769568854, 13072.477100916047, 13094.214347139203, 13096.803547946789, 13106.541271055466, 13126.01554883378, 12008.339541325224, 12250.387480626023, 12372.072094592851, 12599.236106945034, 12754.0, 11435.59975400857, 11462.312261264351, 11497.540098396054, 11499.597514086967, 11548.53805847765, 4129.876103716893, 4185.434966279544, 4190.392393103013, 4229.936550951738, 4308.31067029277, 45793.5420645796, 45824.770876145405, 45903.0, 45989.5401045992, 45994.0, 9462.858057129148, 9856.162226210852, 9872.901270987199, 9897.554610042565, 9948.900510994943, 15981.840181598267, 16015.119168445848, 16016.919915400349, 16035.518934431986, 16144.596385090466, 6731.697073631698, 6739.629320387426, 6755.864882702318, 6765.357291057342, 6944.0, 3849.287881741887, 3856.73002889795, 3900.7464514806447, 3913.8238779255003, 3950.249452603996, 2886.1774394297527, 2948.660903996068, 2984.030190188154, 2984.612000439929, 2985.0, 536.2599612534677, 539.4120408754477, 543.1987817968544, 551.8510002299357, 563.808305176242, 479.13755240567536, 581.9447152520504, 585.4789237578558, 586.8532965889128, 600.8738164985315, 7434.516756410816, 7516.210797866145, 7569.394448444111, 7600.80997975055, 7732.149463559004, 505.56016265848945, 530.7982966472715, 560.8766071464353, 567.9801206957819, 585.844751140948, 3628.1836586768295, 3646.9817650911577, 3672.6327367263593, 3677.2461645362637, 3751.4935483709896, 59432.40567594269, 59936.0, 60397.0, 60706.69646651739, 61043.08435373473, 51189.0, 52628.73685631624, 52874.0, 52874.73562632239, 54689.0, 47558.762206189436, 48178.518214817406, 50066.0, 50414.495855041714, 50925.745371272904, 6753.932460675331, 6830.521863469509, 7021.1574611047, 7031.613261270474, 7089.184743754534, 32197.839010804797, 32284.677153228167, 32349.67650323561, 32744.508832367057, 33040.0, 39958.60041399549, 42255.56316586714, 43126.35310470408, 43740.84461976107, 44147.0, 8181.509109453452, 8350.87473687883, 8412.411131220755, 8599.656013759379, 8752.606132723915, 9588.808223835345, 9831.213502919893, 9967.700968970943, 10001.199904007517, 10110.19118470506, 9711.417314961125, 9730.12428881404, 9875.604975800887, 9879.20966322678, 10043.0, 9512.051209583462, 9578.13796758295, 9660.275479338938, 9700.708978730649, 9788.412695238309, 8721.345899057724, 8848.557572121239, 8968.775780605276, 9363.531823408939, 9408.388454750419, 7156.821079473055, 7160.749373771893, 7509.249075092447, 7682.270184332479, 7800.102988156435, 8057.516549006844, 8152.0, 8274.669013239403, 8291.378146639147, 8419.494830310201], "value": 5912.676825772502, "unit": "score"}], "name": "dromaeo_css", "value": 6443.422977971952, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 113.0, 115.0, 112.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 138.0, 151.0, 219.0, 133.0, 156.0, 152.0, 131.0, 182.0, 137.0], "value": 156.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 156.0, 75.0, 74.0, 75.0, 74.0, 131.0, 75.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 92.0, 92.0, 92.0, 124.0, 92.0, 93.0, 123.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 84.0, 85.0, 85.0, 82.0, 82.0, 82.0, 139.0, 82.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 139.0, 135.0, 135.0, 143.0, 128.0, 127.0, 141.0, 147.0, 134.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 168.0, 175.0, 168.0, 167.0, 168.0, 167.0, 168.0, 170.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 70.0, 69.0, 66.0, 67.0, 66.0, 67.0, 65.0, 68.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1568.8000000000002, "alertThreshold": 2.0}]} 14:58:00 INFO - Return code: 0 14:58:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:58:01 ERROR - # TBPL SUCCESS # 14:58:01 INFO - Running post-action listener: _resource_record_post_action 14:58:01 INFO - ##### 14:58:01 INFO - ##### Finished run-tests step (success) 14:58:01 INFO - ##### 14:58:01 INFO - Running post-run listener: _resource_record_post_run 14:58:01 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 535289856; Read time: 0; Write time: 687824 14:58:01 INFO - TinderboxPrint: CPU usage
13.1% 14:58:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:58:01 INFO - TinderboxPrint: I/O write bytes / time
535,289,856 / 687,824 14:58:01 INFO - TinderboxPrint: CPU idle
8,335.9 (86.9%) 14:58:01 INFO - TinderboxPrint: CPU user
1,210.2 (12.6%) 14:58:01 INFO - TinderboxPrint: Swap in / out
0 / 0 14:58:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237539328; Read time: 0; Write time: 365508 14:58:01 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291950592; Read time: 0; Write time: 321212 14:58:01 INFO - Running post-run listener: _upload_blobber_files 14:58:01 INFO - Blob upload gear active. 14:58:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:58:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:58:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:58:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:58:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:58:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:05 INFO - (blobuploader) - INFO - Done attempting. 14:58:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:58:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:58:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:06 INFO - (blobuploader) - INFO - Done attempting. 14:58:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:58:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:58:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:07 INFO - (blobuploader) - INFO - Done attempting. 14:58:07 INFO - (blobuploader) - INFO - Iteration through files over. 14:58:07 INFO - Return code: 0 14:58:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:58:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:58:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92c7bb6c05f742de2dab6d4c867bf35a438196e076f6f6cdea836e314fd98b67dc3dbd5169198736e5afd6375b9fe4396289b281cb5d45084ced742e6bf907d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d549df861c87c6b282ad6e484d2185d6619719747ec894af9c4fb75f72c519d73d0bd45f6ca41d41f9e433ebdb7abbed8a63d9098acecd47251b4bb653d9778", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/772cb401ecec529116095ae018f9e8cbe2b6e3b6ecbebf6b085fae2dca51318757f49d6a5d473e3909adabd5a11d453df1fd14459e838a2ce9c23409b4025072"} 14:58:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:58:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:58:07 INFO - Contents: 14:58:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92c7bb6c05f742de2dab6d4c867bf35a438196e076f6f6cdea836e314fd98b67dc3dbd5169198736e5afd6375b9fe4396289b281cb5d45084ced742e6bf907d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d549df861c87c6b282ad6e484d2185d6619719747ec894af9c4fb75f72c519d73d0bd45f6ca41d41f9e433ebdb7abbed8a63d9098acecd47251b4bb653d9778", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/772cb401ecec529116095ae018f9e8cbe2b6e3b6ecbebf6b085fae2dca51318757f49d6a5d473e3909adabd5a11d453df1fd14459e838a2ce9c23409b4025072"} 14:58:07 INFO - Running post-run listener: copy_logs_to_upload_dir 14:58:07 INFO - Copying logs to upload dir... 14:58:07 INFO - mkdir: /builds/slave/test/build/upload/logs 14:58:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.221162 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-14 14:58:05.903286) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 14:58:05.906920) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92c7bb6c05f742de2dab6d4c867bf35a438196e076f6f6cdea836e314fd98b67dc3dbd5169198736e5afd6375b9fe4396289b281cb5d45084ced742e6bf907d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d549df861c87c6b282ad6e484d2185d6619719747ec894af9c4fb75f72c519d73d0bd45f6ca41d41f9e433ebdb7abbed8a63d9098acecd47251b4bb653d9778", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/772cb401ecec529116095ae018f9e8cbe2b6e3b6ecbebf6b085fae2dca51318757f49d6a5d473e3909adabd5a11d453df1fd14459e838a2ce9c23409b4025072"} build_url:https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/LeTv27tMT0C5JugUjfJ4og/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/92c7bb6c05f742de2dab6d4c867bf35a438196e076f6f6cdea836e314fd98b67dc3dbd5169198736e5afd6375b9fe4396289b281cb5d45084ced742e6bf907d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2d549df861c87c6b282ad6e484d2185d6619719747ec894af9c4fb75f72c519d73d0bd45f6ca41d41f9e433ebdb7abbed8a63d9098acecd47251b4bb653d9778", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/772cb401ecec529116095ae018f9e8cbe2b6e3b6ecbebf6b085fae2dca51318757f49d6a5d473e3909adabd5a11d453df1fd14459e838a2ce9c23409b4025072"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 14:58:05.931832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:58:05.932172) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1463260855.336524-1580958104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:58:06.015689) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 14:58:06.016008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 14:58:06.016287) ========= ========= Total master_lag: 0.18 =========