builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1464146420.33 results: success (0) buildid: 20160524194536 builduid: 8c9f3175870843f1a1c685d4c2d13fc7 revision: ea60f9e94a807a0be57df93c9716426b5651b21b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.328942) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.329394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.329666) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.344209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.344528) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 20:20:20-- 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% 46.9M=0s 2016-05-24 20:20:20 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145233 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.503776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.504133) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.553423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:20.553777) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea60f9e94a807a0be57df93c9716426b5651b21b --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 ea60f9e94a807a0be57df93c9716426b5651b21b --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=03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 20:20:20,906 truncating revision to first 12 chars 2016-05-24 20:20:20,907 Setting DEBUG logging. 2016-05-24 20:20:20,907 attempt 1/10 2016-05-24 20:20:20,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea60f9e94a80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 20:20:21,152 unpacking tar archive at: fx-team-ea60f9e94a80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530044 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:21.097074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:21.097390) ========= script_repo_revision: ea60f9e94a807a0be57df93c9716426b5651b21b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:21.097791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:21.098054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 20:20:21.106660) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-24 20:20:21.106934) ========= /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=03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:20:21 INFO - MultiFileLogger online at 20160524 20:20:21 in /builds/slave/test 20:20: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 20:20:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:20:21 INFO - {'append_to_log': False, 20:20:21 INFO - 'base_work_dir': '/builds/slave/test', 20:20:21 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:20:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:20:21 INFO - 'branch': 'Fx-Team-Non-PGO', 20:20:21 INFO - 'buildbot_json_path': 'buildprops.json', 20:20:21 INFO - 'config_files': ('talos/linux_config.py',), 20:20:21 INFO - 'default_actions': ('clobber', 20:20:21 INFO - 'read-buildbot-config', 20:20:21 INFO - 'download-and-extract', 20:20:21 INFO - 'populate-webroot', 20:20:21 INFO - 'create-virtualenv', 20:20:21 INFO - 'install', 20:20:21 INFO - 'run-tests'), 20:20:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:20:21 INFO - 'download_minidump_stackwalk': True, 20:20:21 INFO - 'download_symbols': 'ondemand', 20:20:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:20:21 INFO - 'tooltool.py': '/tools/tooltool.py', 20:20:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:20:21 INFO - '/tools/misc-python/virtualenv.py')}, 20:20:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:20:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:20:21 INFO - 'installer_path': 'installer.exe', 20:20:21 INFO - 'log_level': 'info', 20:20:21 INFO - 'log_name': 'talos', 20:20:21 INFO - 'log_to_console': True, 20:20:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:20:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:20:21 INFO - 'opt_config_files': (), 20:20:21 INFO - 'pip_index': False, 20:20:21 INFO - 'sps_profile': False, 20:20:21 INFO - 'sps_profile_interval': 0, 20:20:21 INFO - 'suite': 'dromaeojs', 20:20:21 INFO - 'system_bits': '32', 20:20:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:20:21 INFO - 'title': 'talos-linux64-ix-047', 20:20:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:20:21 INFO - 'use_talos_json': True, 20:20:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:20:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:20:21 INFO - 'work_dir': 'build'} 20:20:21 INFO - ##### 20:20:21 INFO - ##### Running clobber step. 20:20:21 INFO - ##### 20:20:21 INFO - Running pre-action listener: _resource_record_pre_action 20:20:21 INFO - Running main action method: clobber 20:20:21 INFO - rmtree: /builds/slave/test/build 20:20:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:20:22 INFO - Running post-action listener: _resource_record_post_action 20:20:22 INFO - ##### 20:20:22 INFO - ##### Finished clobber step (success) 20:20:22 INFO - ##### 20:20:22 INFO - ##### 20:20:22 INFO - ##### Running read-buildbot-config step. 20:20:22 INFO - ##### 20:20:22 INFO - Running pre-action listener: _resource_record_pre_action 20:20:22 INFO - Running main action method: read_buildbot_config 20:20:22 INFO - Using buildbot properties: 20:20:22 INFO - { 20:20:22 INFO - "project": "", 20:20:22 INFO - "product": "firefox", 20:20:22 INFO - "script_repo_revision": "production", 20:20:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:20:22 INFO - "repository": "", 20:20:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:20:22 INFO - "buildid": "20160524194536", 20:20:22 INFO - "pgo_build": "False", 20:20:22 INFO - "basedir": "/builds/slave/test", 20:20:22 INFO - "buildnumber": 3004, 20:20:22 INFO - "slavename": "talos-linux64-ix-047", 20:20:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:20:22 INFO - "platform": "ubuntu64_hw", 20:20:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:20:22 INFO - "branch": "fx-team", 20:20:22 INFO - "repo_path": "integration/fx-team", 20:20:22 INFO - "revision": "ea60f9e94a807a0be57df93c9716426b5651b21b", 20:20:22 INFO - "stage_platform": "linux64", 20:20:22 INFO - "builduid": "8c9f3175870843f1a1c685d4c2d13fc7", 20:20:22 INFO - "slavebuilddir": "test" 20:20:22 INFO - } 20:20:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:20:22 INFO - Running post-action listener: _resource_record_post_action 20:20:22 INFO - ##### 20:20:22 INFO - ##### Finished read-buildbot-config step (success) 20:20:22 INFO - ##### 20:20:22 INFO - ##### 20:20:22 INFO - ##### Running download-and-extract step. 20:20:22 INFO - ##### 20:20:22 INFO - Running pre-action listener: _resource_record_pre_action 20:20:22 INFO - Running main action method: download_and_extract 20:20:22 INFO - mkdir: /builds/slave/test/build/tests 20:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:22 INFO - https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:20:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:20:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:20:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:22 INFO - Downloaded 1361 bytes. 20:20:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:20:22 INFO - Using the following test package requirements: 20:20:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:20:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:20:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:22 INFO - u'jsshell-linux-x86_64.zip'], 20:20:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:20:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:20:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:20:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:20:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:20:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:20:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:20:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:22 INFO - https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:23 INFO - Downloaded 22844408 bytes. 20:20:23 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'] 20:20:23 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 20:20:25 INFO - Return code: 0 20:20:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:25 INFO - https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:20:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:20:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:26 INFO - Downloaded 22844408 bytes. 20:20:26 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'] 20:20:26 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 20:20:27 INFO - Return code: 0 20:20:27 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')]} 20:20:27 INFO - https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:20:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:20:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:28 INFO - Downloaded 10840359 bytes. 20:20:28 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'] 20:20:28 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 20:20:28 INFO - Return code: 0 20:20:28 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')]} 20:20:28 INFO - https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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 20:20:30 INFO - Downloaded 54828897 bytes. 20:20:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:30 INFO - mkdir: /builds/slave/test/properties 20:20:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:20:30 INFO - Writing to file /builds/slave/test/properties/build_url 20:20:30 INFO - Contents: 20:20:30 INFO - build_url:https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:20:31 INFO - Running post-action listener: _resource_record_post_action 20:20:31 INFO - Running post-action listener: set_extra_try_arguments 20:20:31 INFO - ##### 20:20:31 INFO - ##### Finished download-and-extract step (success) 20:20:31 INFO - ##### 20:20:31 INFO - ##### 20:20:31 INFO - ##### Running populate-webroot step. 20:20:31 INFO - ##### 20:20:31 INFO - Running pre-action listener: _resource_record_pre_action 20:20:31 INFO - Running main action method: populate_webroot 20:20:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:20:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:20:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:20:31 INFO - '--tppagecycles', 20:20:31 INFO - '7'], 20:20:31 INFO - 'tests': ['tsvgm']}}, 20:20:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:20:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:20:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:20:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:20:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:31 INFO - 'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:20:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:31 INFO - 'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['damp', 'tps']}, 20:20:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:31 INFO - 'tests': ['damp', 'tps']}, 20:20:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['dromaeo_dom']}, 20:20:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:20:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['a11yr', 20:20:31 INFO - 'ts_paint', 20:20:31 INFO - 'tpaint', 20:20:31 INFO - 'sessionrestore', 20:20:31 INFO - 'sessionrestore_no_auto_restore', 20:20:31 INFO - 'tabpaint']}, 20:20:31 INFO - 'other-e10s': {'tests': ['a11yr', 20:20:31 INFO - 'ts_paint', 20:20:31 INFO - 'tpaint', 20:20:31 INFO - 'sessionrestore', 20:20:31 INFO - 'sessionrestore_no_auto_restore', 20:20:31 INFO - 'tabpaint']}, 20:20:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:20:31 INFO - 'ts_paint', 20:20:31 INFO - 'tpaint', 20:20:31 INFO - 'sessionrestore', 20:20:31 INFO - 'sessionrestore_no_auto_restore', 20:20:31 INFO - 'tabpaint']}, 20:20:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:20:31 INFO - 'ts_paint', 20:20:31 INFO - 'tpaint', 20:20:31 INFO - 'sessionrestore', 20:20:31 INFO - 'sessionrestore_no_auto_restore', 20:20:31 INFO - 'tabpaint']}, 20:20:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['a11yr', 20:20:31 INFO - 'ts_paint', 20:20:31 INFO - 'tpaint', 20:20:31 INFO - 'sessionrestore', 20:20:31 INFO - 'sessionrestore_no_auto_restore', 20:20:31 INFO - 'tabpaint']}, 20:20:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['a11yr', 20:20:31 INFO - 'ts_paint', 20:20:31 INFO - 'tpaint', 20:20:31 INFO - 'sessionrestore', 20:20:31 INFO - 'sessionrestore_no_auto_restore', 20:20:31 INFO - 'tabpaint']}, 20:20:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['tsvgx', 20:20:31 INFO - 'tsvgr_opacity', 20:20:31 INFO - 'tart', 20:20:31 INFO - 'tscrollx', 20:20:31 INFO - 'cart']}, 20:20:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:20:31 INFO - 'tsvgr_opacity', 20:20:31 INFO - 'tart', 20:20:31 INFO - 'tscrollx', 20:20:31 INFO - 'cart']}, 20:20:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:31 INFO - 'talos_options': ['--disable-e10s'], 20:20:31 INFO - 'tests': ['tp5o']}, 20:20:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:31 INFO - 'tests': ['tp5o']}, 20:20:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:31 INFO - 'talos_options': ['--disable-e10s', 20:20:31 INFO - '--xperf_path', 20:20:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:31 INFO - 'tests': ['tp5n']}, 20:20:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:20:31 INFO - 'talos_options': ['--xperf_path', 20:20:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:20:31 INFO - 'tests': ['tp5n']}}, 20:20:31 INFO - 'talos.zip': {'path': '', 20:20:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:20:31 INFO - Running post-action listener: _resource_record_post_action 20:20:31 INFO - ##### 20:20:31 INFO - ##### Finished populate-webroot step (success) 20:20:31 INFO - ##### 20:20:31 INFO - ##### 20:20:31 INFO - ##### Running create-virtualenv step. 20:20:31 INFO - ##### 20:20:31 INFO - Running pre-action listener: _resource_record_pre_action 20:20:31 INFO - Running main action method: create_virtualenv 20:20:31 INFO - Creating virtualenv /builds/slave/test/build/venv 20:20:31 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 20:20:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:20:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:20:31 INFO - Using real prefix '/usr' 20:20:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:20:32 INFO - Installing distribute.............................................................................................................................................................................................done. 20:20:34 INFO - Installing pip.................done. 20:20:34 INFO - Return code: 0 20:20:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:34 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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20:34 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 20:20:34 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 20:20:34 INFO - Using env: {'DISPLAY': ':0', 20:20:34 INFO - 'HOME': '/home/cltbld', 20:20:34 INFO - 'LANG': 'en_US.UTF-8', 20:20:34 INFO - 'LANGUAGE': 'en_US:en', 20:20:34 INFO - 'LOGNAME': 'cltbld', 20:20:34 INFO - 'MAIL': '/var/mail/cltbld', 20:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:34 INFO - 'MOZ_NO_REMOTE': '1', 20:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:34 INFO - 'NO_EM_RESTART': '1', 20:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:34 INFO - 'PWD': '/builds/slave/test', 20:20:34 INFO - 'SHELL': '/bin/bash', 20:20:34 INFO - 'SHLVL': '1', 20:20:34 INFO - 'TERM': 'linux', 20:20:34 INFO - 'TMOUT': '86400', 20:20:34 INFO - 'USER': 'cltbld', 20:20:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:34 INFO - '_': '/tools/buildbot/bin/python'} 20:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:34 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 20:20:34 INFO - Cleaning up... 20:20:34 INFO - Return code: 0 20:20:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:34 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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20:34 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 20:20:34 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 20:20:34 INFO - Using env: {'DISPLAY': ':0', 20:20:34 INFO - 'HOME': '/home/cltbld', 20:20:34 INFO - 'LANG': 'en_US.UTF-8', 20:20:34 INFO - 'LANGUAGE': 'en_US:en', 20:20:34 INFO - 'LOGNAME': 'cltbld', 20:20:34 INFO - 'MAIL': '/var/mail/cltbld', 20:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:34 INFO - 'MOZ_NO_REMOTE': '1', 20:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:34 INFO - 'NO_EM_RESTART': '1', 20:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:34 INFO - 'PWD': '/builds/slave/test', 20:20:34 INFO - 'SHELL': '/bin/bash', 20:20:34 INFO - 'SHLVL': '1', 20:20:34 INFO - 'TERM': 'linux', 20:20:34 INFO - 'TMOUT': '86400', 20:20:34 INFO - 'USER': 'cltbld', 20:20:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:34 INFO - '_': '/tools/buildbot/bin/python'} 20:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:34 INFO - Downloading/unpacking psutil>=3.1.1 20:20:34 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 20:20:34 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 20:20:34 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 20:20:34 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 20:20:34 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 20:20:34 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 20:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:20:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:36 INFO - Installing collected packages: psutil 20:20:36 INFO - Running setup.py install for psutil 20:20:36 INFO - building 'psutil._psutil_linux' extension 20:20:36 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 20:20:37 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 20:20:37 INFO - building 'psutil._psutil_posix' extension 20:20:37 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 20:20:37 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 20:20:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:20:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:20:37 INFO - Successfully installed psutil 20:20:37 INFO - Cleaning up... 20:20:37 INFO - Return code: 0 20:20:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:20:37 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')]} 20:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:37 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')]} 20:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:37 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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20:37 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 20:20:37 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 20:20:37 INFO - Using env: {'DISPLAY': ':0', 20:20:37 INFO - 'HOME': '/home/cltbld', 20:20:37 INFO - 'LANG': 'en_US.UTF-8', 20:20:37 INFO - 'LANGUAGE': 'en_US:en', 20:20:37 INFO - 'LOGNAME': 'cltbld', 20:20:37 INFO - 'MAIL': '/var/mail/cltbld', 20:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:37 INFO - 'MOZ_NO_REMOTE': '1', 20:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:37 INFO - 'NO_EM_RESTART': '1', 20:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:37 INFO - 'PWD': '/builds/slave/test', 20:20:37 INFO - 'SHELL': '/bin/bash', 20:20:37 INFO - 'SHLVL': '1', 20:20:37 INFO - 'TERM': 'linux', 20:20:37 INFO - 'TMOUT': '86400', 20:20:37 INFO - 'USER': 'cltbld', 20:20:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:37 INFO - '_': '/tools/buildbot/bin/python'} 20:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:20:39 INFO - Installing collected packages: mozsystemmonitor 20:20:39 INFO - Running setup.py install for mozsystemmonitor 20:20:39 INFO - Successfully installed mozsystemmonitor 20:20:39 INFO - Cleaning up... 20:20:39 INFO - Return code: 0 20:20:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:20: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')]} 20:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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')]} 20:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20: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', '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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:20: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 blobuploader==1.2.4 20:20:39 INFO - Using env: {'DISPLAY': ':0', 20:20:39 INFO - 'HOME': '/home/cltbld', 20:20:39 INFO - 'LANG': 'en_US.UTF-8', 20:20:39 INFO - 'LANGUAGE': 'en_US:en', 20:20:39 INFO - 'LOGNAME': 'cltbld', 20:20:39 INFO - 'MAIL': '/var/mail/cltbld', 20:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:39 INFO - 'MOZ_NO_REMOTE': '1', 20:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:39 INFO - 'NO_EM_RESTART': '1', 20:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:39 INFO - 'PWD': '/builds/slave/test', 20:20:39 INFO - 'SHELL': '/bin/bash', 20:20:39 INFO - 'SHLVL': '1', 20:20:39 INFO - 'TERM': 'linux', 20:20:39 INFO - 'TMOUT': '86400', 20:20:39 INFO - 'USER': 'cltbld', 20:20:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:39 INFO - '_': '/tools/buildbot/bin/python'} 20:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:39 INFO - Downloading/unpacking blobuploader==1.2.4 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:41 INFO - Downloading blobuploader-1.2.4.tar.gz 20:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:20:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:20:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:42 INFO - Downloading docopt-0.6.1.tar.gz 20:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:20:42 INFO - Installing collected packages: blobuploader, requests, docopt 20:20:42 INFO - Running setup.py install for blobuploader 20:20:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:20:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:20:42 INFO - Running setup.py install for requests 20:20:42 INFO - Running setup.py install for docopt 20:20:42 INFO - Successfully installed blobuploader requests docopt 20:20:42 INFO - Cleaning up... 20:20:43 INFO - Return code: 0 20:20:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:43 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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20:43 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 20:20:43 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 20:20:43 INFO - Using env: {'DISPLAY': ':0', 20:20:43 INFO - 'HOME': '/home/cltbld', 20:20:43 INFO - 'LANG': 'en_US.UTF-8', 20:20:43 INFO - 'LANGUAGE': 'en_US:en', 20:20:43 INFO - 'LOGNAME': 'cltbld', 20:20:43 INFO - 'MAIL': '/var/mail/cltbld', 20:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:43 INFO - 'MOZ_NO_REMOTE': '1', 20:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:43 INFO - 'NO_EM_RESTART': '1', 20:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:43 INFO - 'PWD': '/builds/slave/test', 20:20:43 INFO - 'SHELL': '/bin/bash', 20:20:43 INFO - 'SHLVL': '1', 20:20:43 INFO - 'TERM': 'linux', 20:20:43 INFO - 'TMOUT': '86400', 20:20:43 INFO - 'USER': 'cltbld', 20:20:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:43 INFO - '_': '/tools/buildbot/bin/python'} 20:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:43 INFO - Running setup.py (path:/tmp/pip-70sSIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:43 INFO - Running setup.py (path:/tmp/pip-92dN_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:43 INFO - Running setup.py (path:/tmp/pip-JpL1Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:43 INFO - Running setup.py (path:/tmp/pip-esFy56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:43 INFO - Running setup.py (path:/tmp/pip-gufyhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:43 INFO - Running setup.py (path:/tmp/pip-uVFIOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:43 INFO - Running setup.py (path:/tmp/pip-Yxgr32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:43 INFO - Running setup.py (path:/tmp/pip-jRrZpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:43 INFO - Running setup.py (path:/tmp/pip-k2FGYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:43 INFO - Running setup.py (path:/tmp/pip-WzQdIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:43 INFO - Running setup.py (path:/tmp/pip-SKiTo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:44 INFO - Running setup.py (path:/tmp/pip-0coBJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:44 INFO - Running setup.py (path:/tmp/pip-RUiYYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:44 INFO - Running setup.py (path:/tmp/pip-sEynfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:44 INFO - Running setup.py (path:/tmp/pip-dlCeGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:44 INFO - Running setup.py (path:/tmp/pip-Z2FULh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:44 INFO - Running setup.py (path:/tmp/pip-V7f0bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:20:44 INFO - Running setup.py install for manifestparser 20:20:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:20:44 INFO - Running setup.py install for mozcrash 20:20:44 INFO - Running setup.py install for mozdebug 20:20:44 INFO - Running setup.py install for mozdevice 20:20:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:20:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:20:44 INFO - Running setup.py install for mozfile 20:20:45 INFO - Running setup.py install for mozhttpd 20:20:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Running setup.py install for mozinfo 20:20:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Running setup.py install for mozInstall 20:20:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Running setup.py install for mozleak 20:20:45 INFO - Running setup.py install for mozlog 20:20:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Running setup.py install for moznetwork 20:20:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Running setup.py install for mozprocess 20:20:45 INFO - Running setup.py install for mozprofile 20:20:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Running setup.py install for mozrunner 20:20:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:20:45 INFO - Running setup.py install for mozscreenshot 20:20:46 INFO - Running setup.py install for moztest 20:20:46 INFO - Running setup.py install for mozversion 20:20:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:20:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:20:46 INFO - Cleaning up... 20:20:46 INFO - Return code: 0 20:20:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:46 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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20:46 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 20:20:46 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 20:20:46 INFO - Using env: {'DISPLAY': ':0', 20:20:46 INFO - 'HOME': '/home/cltbld', 20:20:46 INFO - 'LANG': 'en_US.UTF-8', 20:20:46 INFO - 'LANGUAGE': 'en_US:en', 20:20:46 INFO - 'LOGNAME': 'cltbld', 20:20:46 INFO - 'MAIL': '/var/mail/cltbld', 20:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:46 INFO - 'MOZ_NO_REMOTE': '1', 20:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:46 INFO - 'NO_EM_RESTART': '1', 20:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:46 INFO - 'PWD': '/builds/slave/test', 20:20:46 INFO - 'SHELL': '/bin/bash', 20:20:46 INFO - 'SHLVL': '1', 20:20:46 INFO - 'TERM': 'linux', 20:20:46 INFO - 'TMOUT': '86400', 20:20:46 INFO - 'USER': 'cltbld', 20:20:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:46 INFO - '_': '/tools/buildbot/bin/python'} 20:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:20:46 INFO - Running setup.py (path:/tmp/pip-vQgYo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:20:46 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)) 20:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:20:46 INFO - Running setup.py (path:/tmp/pip-iC2_qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:20:46 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)) 20:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:20:46 INFO - Running setup.py (path:/tmp/pip-kgcdPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:20:46 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)) 20:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:20:46 INFO - Running setup.py (path:/tmp/pip-cDsW3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:20:46 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)) 20:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:20:46 INFO - Running setup.py (path:/tmp/pip-6_da_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:20:46 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)) 20:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:20:46 INFO - Running setup.py (path:/tmp/pip-aZQacR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:20:46 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)) 20:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:20:46 INFO - Running setup.py (path:/tmp/pip-TxZm_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:20:47 INFO - Running setup.py (path:/tmp/pip-soe9Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:20:47 INFO - Running setup.py (path:/tmp/pip-ja50r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:20:47 INFO - Running setup.py (path:/tmp/pip-iY1u3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:20:47 INFO - Running setup.py (path:/tmp/pip-IvIpsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:20:47 INFO - Running setup.py (path:/tmp/pip-7GMRvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:20:47 INFO - Running setup.py (path:/tmp/pip-AXGVo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:20:47 INFO - Running setup.py (path:/tmp/pip-3qD36e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:47 INFO - Running setup.py (path:/tmp/pip-lCmsV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:20:47 INFO - Running setup.py (path:/tmp/pip-32wHbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:20:47 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)) 20:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:20:47 INFO - Running setup.py (path:/tmp/pip-VYMrX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:20:47 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)) 20:20:47 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)) 20:20:47 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)) 20:20:47 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)) 20:20:47 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)) 20:20:47 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)) 20:20:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:20:49 INFO - Downloading blessings-1.6.tar.gz 20:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:20:49 INFO - Installing collected packages: blessings 20:20:49 INFO - Running setup.py install for blessings 20:20:49 INFO - Successfully installed blessings 20:20:49 INFO - Cleaning up... 20:20:49 INFO - Return code: 0 20:20:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:20:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:50 INFO - Reading from file tmpfile_stdout 20:20:50 INFO - Current package versions: 20:20:50 INFO - argparse == 1.2.1 20:20:50 INFO - blessings == 1.6 20:20:50 INFO - blobuploader == 1.2.4 20:20:50 INFO - docopt == 0.6.1 20:20:50 INFO - manifestparser == 1.1 20:20:50 INFO - mozInstall == 1.12 20:20:50 INFO - mozcrash == 0.17 20:20:50 INFO - mozdebug == 0.1 20:20:50 INFO - mozdevice == 0.48 20:20:50 INFO - mozfile == 1.2 20:20:50 INFO - mozhttpd == 0.7 20:20:50 INFO - mozinfo == 0.9 20:20:50 INFO - mozleak == 0.1 20:20:50 INFO - mozlog == 3.2 20:20:50 INFO - moznetwork == 0.27 20:20:50 INFO - mozprocess == 0.22 20:20:50 INFO - mozprofile == 0.28 20:20:50 INFO - mozrunner == 6.11 20:20:50 INFO - mozscreenshot == 0.1 20:20:50 INFO - mozsystemmonitor == 0.3 20:20:50 INFO - moztest == 0.7 20:20:50 INFO - mozversion == 1.4 20:20:50 INFO - psutil == 3.1.1 20:20:50 INFO - requests == 1.2.3 20:20:50 INFO - wsgiref == 0.1.2 20:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:20:50 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')]} 20:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:50 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')]} 20:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:50 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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20:50 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 20:20:50 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 20:20:50 INFO - Using env: {'DISPLAY': ':0', 20:20:50 INFO - 'HOME': '/home/cltbld', 20:20:50 INFO - 'LANG': 'en_US.UTF-8', 20:20:50 INFO - 'LANGUAGE': 'en_US:en', 20:20:50 INFO - 'LOGNAME': 'cltbld', 20:20:50 INFO - 'MAIL': '/var/mail/cltbld', 20:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:50 INFO - 'MOZ_NO_REMOTE': '1', 20:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:50 INFO - 'NO_EM_RESTART': '1', 20:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:50 INFO - 'PWD': '/builds/slave/test', 20:20:50 INFO - 'SHELL': '/bin/bash', 20:20:50 INFO - 'SHLVL': '1', 20:20:50 INFO - 'TERM': 'linux', 20:20:50 INFO - 'TMOUT': '86400', 20:20:50 INFO - 'USER': 'cltbld', 20:20:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:50 INFO - '_': '/tools/buildbot/bin/python'} 20:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 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)) 20:20:50 INFO - Cleaning up... 20:20:50 INFO - Return code: 0 20:20:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:20:50 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')]} 20:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:50 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')]} 20:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:50 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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20:50 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 20:20:50 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 20:20:50 INFO - Using env: {'DISPLAY': ':0', 20:20:50 INFO - 'HOME': '/home/cltbld', 20:20:50 INFO - 'LANG': 'en_US.UTF-8', 20:20:50 INFO - 'LANGUAGE': 'en_US:en', 20:20:50 INFO - 'LOGNAME': 'cltbld', 20:20:50 INFO - 'MAIL': '/var/mail/cltbld', 20:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:50 INFO - 'MOZ_NO_REMOTE': '1', 20:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:50 INFO - 'NO_EM_RESTART': '1', 20:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:50 INFO - 'PWD': '/builds/slave/test', 20:20:50 INFO - 'SHELL': '/bin/bash', 20:20:50 INFO - 'SHLVL': '1', 20:20:50 INFO - 'TERM': 'linux', 20:20:50 INFO - 'TMOUT': '86400', 20:20:50 INFO - 'USER': 'cltbld', 20:20:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:50 INFO - '_': '/tools/buildbot/bin/python'} 20:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:50 INFO - Downloading/unpacking jsonschema 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:20:52 INFO - Downloading/unpacking functools32 (from jsonschema) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:52 INFO - Downloading functools32-3.2.3-2.tar.gz 20:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:20:52 INFO - warning: no files found matching '*.txt' 20:20:52 INFO - no previously-included directories found matching 'build' 20:20:52 INFO - no previously-included directories found matching 'dist' 20:20:52 INFO - no previously-included directories found matching '.git*' 20:20:52 INFO - Installing collected packages: jsonschema, functools32 20:20:52 INFO - Running setup.py install for functools32 20:20:52 INFO - warning: no files found matching '*.txt' 20:20:52 INFO - no previously-included directories found matching 'build' 20:20:52 INFO - no previously-included directories found matching 'dist' 20:20:52 INFO - no previously-included directories found matching '.git*' 20:20:53 INFO - Successfully installed jsonschema functools32 20:20:53 INFO - Cleaning up... 20:20:53 INFO - Return code: 0 20:20:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:20:53 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')]} 20:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:53 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')]} 20:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:20:53 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 0x7f5cb6b67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15cf770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, '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': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', '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 20:20:53 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 20:20:53 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 20:20:53 INFO - Using env: {'DISPLAY': ':0', 20:20:53 INFO - 'HOME': '/home/cltbld', 20:20:53 INFO - 'LANG': 'en_US.UTF-8', 20:20:53 INFO - 'LANGUAGE': 'en_US:en', 20:20:53 INFO - 'LOGNAME': 'cltbld', 20:20:53 INFO - 'MAIL': '/var/mail/cltbld', 20:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:53 INFO - 'MOZ_NO_REMOTE': '1', 20:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:53 INFO - 'NO_EM_RESTART': '1', 20:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:53 INFO - 'PWD': '/builds/slave/test', 20:20:53 INFO - 'SHELL': '/bin/bash', 20:20:53 INFO - 'SHLVL': '1', 20:20:53 INFO - 'TERM': 'linux', 20:20:53 INFO - 'TMOUT': '86400', 20:20:53 INFO - 'USER': 'cltbld', 20:20:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:53 INFO - '_': '/tools/buildbot/bin/python'} 20:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:20:53 INFO - Downloading/unpacking flake8 20:20:53 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 20:20:53 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 20:20:53 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 20:20:53 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 20:20:53 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 20:20:53 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 20:20:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:20:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:20:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20: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 20:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:20:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:20:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:20:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:20:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:20:55 INFO - no previously-included directories found matching 'docs/_build' 20:20:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:20:55 INFO - Running setup.py install for pep8 20:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:20:56 INFO - no previously-included directories found matching 'docs/_build' 20:20:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:20:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:20:56 INFO - Cleaning up... 20:20:56 INFO - Return code: 0 20:20:56 INFO - Running post-action listener: _resource_record_post_action 20:20:56 INFO - Running post-action listener: _start_resource_monitoring 20:20:56 INFO - Starting resource monitoring. 20:20:56 INFO - ##### 20:20:56 INFO - ##### Finished create-virtualenv step (success) 20:20:56 INFO - ##### 20:20:56 INFO - ##### 20:20:56 INFO - ##### Running install step. 20:20:56 INFO - ##### 20:20:56 INFO - Running pre-action listener: _resource_record_pre_action 20:20:56 INFO - Running main action method: install 20:20:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:20:56 INFO - Reading from file tmpfile_stdout 20:20:56 INFO - Detecting whether we're running mozinstall >=1.0... 20:20:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:20:56 INFO - Reading from file tmpfile_stdout 20:20:56 INFO - Output received: 20:20:56 INFO - Usage: mozinstall [options] installer 20:20:56 INFO - Options: 20:20:56 INFO - -h, --help show this help message and exit 20:20:56 INFO - -d DEST, --destination=DEST 20:20:56 INFO - Directory to install application into. [default: 20:20:56 INFO - "/builds/slave/test"] 20:20:56 INFO - --app=APP Application being installed. [default: firefox] 20:20:56 INFO - mkdir: /builds/slave/test/build/application 20:20:56 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'] 20:20:56 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 20:21:12 INFO - Reading from file tmpfile_stdout 20:21:12 INFO - Output received: 20:21:12 INFO - /builds/slave/test/build/application/firefox/firefox 20:21:12 INFO - Running post-action listener: _resource_record_post_action 20:21:12 INFO - ##### 20:21:12 INFO - ##### Finished install step (success) 20:21:12 INFO - ##### 20:21:12 INFO - ##### 20:21:12 INFO - ##### Running run-tests step. 20:21:12 INFO - ##### 20:21:12 INFO - Running pre-action listener: _resource_record_pre_action 20:21:12 INFO - Running main action method: run_tests 20:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:21:12 INFO - Python 2.7.3 20:21:12 INFO - Return code: 0 20:21:12 INFO - grabbing minidump binary from tooltool 20:21:12 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')]} 20:21:12 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 0x165e9c0>, '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 0x165f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:21:12 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 20:21:12 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 20:21:12 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 20:21:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:21:12 INFO - Return code: 0 20:21:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:21:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:21:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:21:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:21:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:21:13 INFO - Return code: 0 20:21:13 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/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 20:21:13 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/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 20:21:13 INFO - Using env: {'DISPLAY': ':0', 20:21:13 INFO - 'HOME': '/home/cltbld', 20:21:13 INFO - 'LANG': 'en_US.UTF-8', 20:21:13 INFO - 'LANGUAGE': 'en_US:en', 20:21:13 INFO - 'LOGNAME': 'cltbld', 20:21:13 INFO - 'MAIL': '/var/mail/cltbld', 20:21:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:21:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:21:13 INFO - 'MOZ_NO_REMOTE': '1', 20:21:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:21:13 INFO - 'NO_EM_RESTART': '1', 20:21:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:21:13 INFO - 'PWD': '/builds/slave/test', 20:21:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:21:13 INFO - 'SHELL': '/bin/bash', 20:21:13 INFO - 'SHLVL': '1', 20:21:13 INFO - 'TERM': 'linux', 20:21:13 INFO - 'TMOUT': '86400', 20:21:13 INFO - 'USER': 'cltbld', 20:21:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401', 20:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:21:13 INFO - '_': '/tools/buildbot/bin/python'} 20:21:13 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/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 20:21:13 INFO - mozversion application_buildid: 20160524194536 20:21:13 INFO - mozversion application_changeset: ea60f9e94a807a0be57df93c9716426b5651b21b 20:21:13 INFO - mozversion application_display_name: Nightly 20:21:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:21:13 INFO - mozversion application_name: Firefox 20:21:13 INFO - mozversion application_remotingname: firefox 20:21:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:21:13 INFO - mozversion application_vendor: Mozilla 20:21:13 INFO - mozversion application_version: 49.0a1 20:21:13 INFO - mozversion platform_buildid: 20160524194536 20:21:13 INFO - mozversion platform_changeset: ea60f9e94a807a0be57df93c9716426b5651b21b 20:21:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:21:13 INFO - mozversion platform_version: 49.0a1 20:21:13 INFO - using testdate: 1464146473 20:21:13 INFO - actual date: 1464146473 20:21:13 INFO - starting webserver on 'localhost:35814' 20:21:13 INFO - SUITE-START | Running 2 tests 20:21:13 INFO - TEST-START | dromaeo_css 20:21:13 INFO - operating with platform_type : linux_ 20:21:13 INFO - Initialising browser for dromaeo_css test... 20:21:13 INFO - TEST-INFO | started process 8766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF6SGRB/profile http://localhost:35814/getInfo.html) 20:21:17 INFO - PROCESS | 8766 | __metrics Screen width/height:1600/1200 20:21:17 INFO - PROCESS | 8766 | colorDepth:24 20:21:17 INFO - PROCESS | 8766 | Browser inner width/height: 1024/697 20:21:17 INFO - PROCESS | 8766 | __metrics 20:21:18 ERROR - PROCESS | 8766 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:21:19 INFO - TEST-INFO | 8766: exit 0 20:21:19 INFO - Browser initialized. 20:21:19 INFO - Running cycle 1/1 for dromaeo_css test... 20:21:19 INFO - TEST-INFO | started process 8850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF6SGRB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:31 INFO - PROCESS | 8850 | RSS: Main: 154419200 20:21:31 INFO - PROCESS | 8850 | 20:22:23 INFO - PROCESS | 8850 | 1464146543548 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] 20:24:35 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:35814/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35814/tests/dromaeo/cssquery-ext.html) 20:24:36 INFO - PROCESS | 8850 | RSS: Main: 237342720 20:24:36 INFO - PROCESS | 8850 | 20:27:38 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:35814/tests/dromaeo/cssquery-ext.html (next: http://localhost:35814/tests/dromaeo/cssquery-jquery.html) 20:27:39 INFO - PROCESS | 8850 | RSS: Main: 246452224 20:27:39 INFO - PROCESS | 8850 | 20:30:41 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:35814/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35814/tests/dromaeo/cssquery-mootools.html) 20:30:42 INFO - PROCESS | 8850 | RSS: Main: 240234496 20:30:42 INFO - PROCESS | 8850 | 20:33:44 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:35814/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35814/tests/dromaeo/cssquery-prototype.html) 20:33:44 INFO - PROCESS | 8850 | RSS: Main: 239300608 20:33:44 INFO - PROCESS | 8850 | 20:36:47 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:35814/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35814/tests/dromaeo/cssquery-yui.html) 20:36:48 INFO - PROCESS | 8850 | RSS: Main: 215199744 20:36:48 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | Cycle 1(1): loaded http://localhost:35814/tests/dromaeo/cssquery-yui.html (next: http://localhost:35814/tests/dromaeo/cssquery-dojo.html) 20:39:51 INFO - PROCESS | 8850 | RSS: Main: 281927680 20:39:51 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | __start_tp_report 20:39:51 INFO - PROCESS | 8850 | _x_x_mozilla_page_load 20:39:51 INFO - PROCESS | 8850 | _x_x_mozilla_page_load_details 20:39:51 INFO - PROCESS | 8850 | |i|pagename|runs| 20:39:51 INFO - PROCESS | 8850 | |0;dojo.html;2676.772474339681;2698.136596289188;2721.3323770818397;2724.209979106058;2756.2971442282214;4577.198990176722;4648.9767551162195;4661.557152070553;4761.785719642611;4810.206315957867;4706.576408123268;4707.576318131368;4779.928301075487;4840.830570930018;4853;4299.118680670455;4350.80421381037;4375.059362237118;4406.184855801687;4526.97736511317;4437;4453.88865278369;4478.305862591287;4481.439820022497;4517.412736344287;4323.070539833935;4366.104948485553;4401.053773438726;4411.250087485135;4433.889152771174;4347.260965635849;4354.542773008852;4364.825406983717;4405.427294451701;4407.427034485529;4398.186335527937;4399.626031787302;4402.933955990663;4441.467023957113;4450.710703804242;4577.793999270041;4632.328312394718;4680.251159814447;4695.67130300879;4743.596794272491;5125.487451254882;5140.820071297524;5148.382194136728;5157.896842063175;5158.845234642929;5139.254808052849;5146.614003949719;5169.095408303532;5182.300389447451;5183.714895680736;4653.139169253699;4809.230523116355;4818.253170758538;4861.9027619447415;4872.293517439952;5249.081410753103;5271.314729085195;5271.815486458032;5317.574594032545;5332.280142180756;4823.493533178966;5064.569511591482;5076.6446348755235;5077.543021128116;5079.6698214615935;5096.719680417538;5132.10188217068;5138.486151384832;5153.149730294459;5173.3533308336455;5128.948710512922;5138.717370544656;5150.742462876841;5155.304033955443;5191.740412979336;4900.534449227318;5014.899702006012;5129.589632829439;5140.845774626767;5143.048536020848;4345.9130817383475;4357.346398040319;4362.280223763044;4407.052483715952;4407.625351845065;3777.9433308500393;3802.8478860845257;3811.123441608446;3847.153626202231;3847.3844184930276;4322.37325587788;4371.388005679208;4420.756858372821;4435.667324950641;4436.933445998313;5171.069207542603;5182.4299327073995;5203.869903252374;5206.817761378334;5259.684418934876;4499.820007199741;4508.458984921765;4510.8421205257655;4517.503074661785;4560.0195957868555;4549.954500455019;4606.286025666027;4635.860924172281;4717.528247175255;4748.738819364899;4814;4831.903361932671;4837.153498137742;4877.561019508332;4879.609631229564;5132.5124113209185;5136.922946155736;5140.640155189101;5142.305788718475;5142.922856157235;4629.629629629554;4745.833895813768;4777.976110119427;4789.760511974457;4883.926741098958;4995.62532810048;5010.949890501049;5010.974945125251;5013.047520971004;5013.147764880052;5072.82245121419;5079.9238011429115;5081.72050537224;5082.4917508250355;5113.693178409308;4881.633877459134;4950.603951683928;5004.524570165829;5012.3233363495465;5025.145725226794;4995.525425084611;5029.396472423333;5034.0938631046765;5035.748212589429;5083.92374114396;4768.928466072943;4942.703437793743;4963.379577552806;4967.925481117713;5015.172496538176;4917.188663870565;5016.724080175625;5034.421041580265;5046.1926091825135;5049.899002019865;4856.878578035577;4864.294677271847;4904.6566740327835;4909.337239472626;4912.778924948315 20:39:51 INFO - PROCESS | 8850 | |1;ext.html;593.5785592229514;594.260146118083;595.5711887441043;612.5099920063954;613.549041454531;41004.179916401656;42465.15069698604;42652.36021459677;46511.30233046498;46573.30140047902;43972.56027439725;44581.77709111458;44655;44746.55253447464;44788.55211447884;7657.23427657234;7812.3359514441345;7877.606119694021;7887.1324154343265;7889.763307100796;7826.413019023567;7909.960450197741;7914.920850791476;7921;7930.008748906387;7892.368610511146;7938.880916786253;7954.244346787046;7961.761147165595;7963.084245311777;7872.252136047066;7914.762557123296;7932.960335198345;7941.086775020831;7941.28528432441;7718.266764657348;7834.255745704149;7853.5680537570415;7856.371490280764;7856.685732570691;40749.388759168636;41104.794476027426;41137.382939255935;41195.79402103;41222.38166427506;3278.393497203001;3408.7102596279096;3555;3653.7807731535927;3766.924661506782;30481.542776858365;30807.845960770275;30858.382832343228;31470.527942080887;32385.676143238503;3505.2814173094453;3566.964330356689;3588.174719814457;3719.237556300952;3723.8510459581585;278391;278819;278926;279940;279997;48107;49570.50429495659;54724;55707.72146139244;55734;47785.52214477811;48223.5177648219;48682.26976595354;48981;49098.263526047136;14521.636959076108;14794.630134246514;14829.555113346616;14852.777208341884;14877.702445951238;10072.294939354322;10852.620158294421;11332.43337833105;11461.942690286662;11464.140189485655;16211.27049282785;16552.83447165537;16678.58303542421;16753;16896.662066758596;6460.612363258219;6580.045893345438;6617.702203400859;6698.866022679519;6736.922092465182;814.2061490047157;845.8308338332358;845.9873101903477;896.7040876510736;912.7444315591645;26636.866815666184;28317.433651326857;28859.567106493418;28902.132936011953;28908.566371504443;989.6091044037565;1005.788784355279;1033.8035773203067;1041.3595638682307;1057.613970900631;14103.884417337482;14594.562163135122;14603.517402041678;14842.554723358317;14909.701805964038;399865;401063;404553;404675;404944;50923.49076509262;52289.47710522846;52378;52397.73801131046;52490.21264681033;1084.3168803653648;1179.3690375648987;1202.4348556178757;1216.2398500936915;1240.522398876421;28045.439091218468;28806.567901481914;29375.412491750474;29475.705242948156;29848.403031939673;43059.78470107629;43364.566354337316;43867.341989869536;43881;43915.78042109769;307128;309548;311336;311943;312302;31220.37559248757;37823.243535129695;38661;38895;41938.580614193466;43768.343474847265;43883;44236.55763442325;44657.33014004857;44770.77614611906;36321;36985;37040.6295937048;37218;37584.624153758115;37093.81453092717;37396.6260337404;37553.06117347088;37753.24493510169;37892;35782.64217357793;36168.09579760527;37519.812400938914;38320.80839595896;38416.6158338413;32421.837890810395;34060.14849628779;34122.948406381576;34427.4835877457;34743.13142171466;26136.8693156533;26160.476790463705;26268.474630507666;26418.207453776417;26555.60166597464 20:39:51 INFO - PROCESS | 8850 | |2;jquery.html;352.3991594331664;354.9520814690016;356.7681007345226;363.99090022749414;377.260569284203;15775.368985240591;16667.16664166793;16966.575835604115;16997.57506062349;17262.395816146436;16228.513144605651;16606.66786664266;17226.397076102337;17259.568510787238;17289.30842766288;4921.212605983043;5093.236014597822;5096.286519887219;5109.310243117169;5116.437191908905;3742.981285093571;3898.142408670088;5079.542841144296;5508.476694713996;5811.6803575803315;5801.187833703285;5803.593748437611;5838.824835254949;5846.853828654275;5849.444302791228;5763.654180749148;5783.768649254025;5918.704064796786;5920.763169473216;5945.405459454063;3375.662433756629;4885.926711099336;5177.45636708144;5185.066687996159;5187.974060129675;20269.695954560695;20801.5839683207;20855;21114.788852111436;21150;1897.5161333859915;1937.1960636335903;1965.8329042031444;2181.3237896252213;2388.7014123234594;8998.910010899872;9313.813723725487;9578.521073946344;9727.708168754949;12933.417996190099;1734.6617409605133;1788.7495750594926;1817.5637846916777;1830.7528483654803;1832.5052235896367;71566.64216678936;72013.27986720118;72065.6396718013;72812;73187.63406182989;9917.206623470105;10028.29801913859;10169.491525423698;10224.926382729855;10505.264631475877;14136.50522231717;14345;14383.928080359532;14389.136651800925;14399.280035998157;7212.891806622905;7234.457415693844;7266.745663901844;7394.593297368697;7504.099508059068;6520.445762110274;6715.7985260442265;6716.731330746716;6728.394444500019;6763.7632682855865;4418.094290670405;4429.357743127229;4444.2222611042935;4467.30756732707;4491.595756381876;1689.2820551265909;1766.5406994181349;1811.18360948726;1860.9534761631066;1881.0970734047735;386.70610336144733;399.60838378389343;405.0824881643081;820.2658620534588;908.1826356279402;9893.802123957481;10197.541110650038;10248.795024099625;10331;10530.10494107994;416.44820612688306;424.08186276711194;429.2338176355191;431.2862213037428;437.4815843225788;5479.205515200353;5523.254360661259;5589.345061096028;5631.802886898939;5641.266635337462;365668;371454;377793;385356;390338;78669.21330786619;79089.60455197802;79138.60430697925;79142.20857791463;80130.19869801344;433.518794138506;437.04723702329227;442.28570858063995;442.7763979190553;442.92248856449993;9913.504324783587;9983;9991;10005.899941000496;10058.798824023332;29416.705832942254;34174.487382689775;34197;35864;36062.09844753902;48771.268430974276;51131.23303150381;51643.74178129085;52096.479035209166;52268;7387;7397.556146631219;7521.0974683038385;7531.472796904164;7671;8360.83278334442;9397.530123493661;10990;10991.505382257657;11312.264702794291;9368.25053995665;9827.361221520578;9856.704298871045;9864.802703945737;9884.851727223953;9601.183899368632;9766.853497197406;9773.31586788918;9794.216462682825;9935.65225217114;9129.863052054092;9618.278629102706;9947.801043978936;10048.748781280527;10302.072813446826;7395.556266624019;7519.586422746802;7523.5109717870355;7638.961805190938;7721.53670779755;9232;9243.953780231055;9527.952360238154;9566.282528810507;9656.662016829658 20:39:51 INFO - PROCESS | 8850 | |3;mootools.html;1225.4179264849192;1418.4609848257664;1442.2356151239842;1558.6103474131467;1778.7509748635193;6852.5203235773515;7745.767626971193;7948.642311096;7954.0852801927795;8193.139720329369;7968.920310796891;8109.270165685087;8112.634931428085;8121.959390203056;8125.553094579811;1922.356010736398;2141.357592722185;2153.8061574458297;2171.0338899189865;2212.4911270407815;2211.7677643847405;2226.487907781211;2231.7545070042283;2232.151782322715;2239;2177.0856240379;2197.373748481683;2212.6459766437374;2215.0475295622878;2216.3794137641485;1841.6961201401753;2081.4805192209774;2139.6683514055267;2157.967630485544;2165.0257384177185;2175.8150557202657;2176.836737244713;2192.8684278943156;2195.4730864592543;2197.8900655169195;8115.95942020292;8145.796355091111;8153.266206041485;8158.306543943772;8164.101948785629;4576.336431217454;4752.215884379073;4760.190767569521;4763.833265835679;4764.499727528594;2893.3489964757973;2920.0801747449486;2967.3768508613216;3095.5356696495483;3097.2876238465055;910.1717437132178;917.0554329041098;924.4730503612943;935.1069728409353;952.1811242331589;11130.220884538086;11136.610218642309;11153.051990580729;11180.776384472347;11230.999999999918;4077.85727499542;4230.238557059759;4298.505671847715;4311.223979683625;4320.373545835836;9409.38838975478;9452.243820494345;9481.194098501566;9484.430934143973;9497.050294970586;4646.117237724821;4671.649626278043;4694.50707675696;4696.03731235096;4696.436427628638;3789.6589306961955;4185.727927684691;4314.69797114199;4315.1585440838735;4377.277749171351;3660.5607327120915;3680.227152297994;3750.5124333836425;3761.5298087739034;3781.489498917666;1183.1838128472752;1187.2460987273143;1198.2630682130427;1203.1638011582043;1208.0275378320362;734.2107234722695;848.9957550212209;869.3175856952262;880.6961598248594;885.5926273914072;5179.81870634526;5282.339707536558;5400.162974738922;5446.754896029688;5457.972710136424;389.44892976438024;391.0907140897425;402.9113595009093;406.28088283737617;409.4676920003983;3669.3395188865725;3733.6826369758874;3739.457778622085;3766.0584853786554;3767.4913886625504;9603.37578057424;9916.206703463706;10014.399136051714;10015.148712359385;10020;9621;9763;9890.65382711616;9911.454869982075;9966.152877005536;7485.438592105614;7530.472866899374;7575.280348366897;7590.658420371096;7617.390608751398;5203.323567936144;5296.549793267462;5362.3833259174135;5419.539339156216;5429.294191755047;8981.506017168856;9019.909800901907;9215.078492150731;9338.112879276458;9367.672131475365;9148.725538233864;9338.719838404859;9339.392939458914;9420.528973551433;9501.857472137784;6213.440790328892;6585.242697089896;6787.490938179558;6915.78973679594;6989.8951515726285;7740.496867703581;7743.070831500256;7811.375089992901;7812.1797211292;7812.843743124992;6851.280615535297;6908.48186386013;7062.293770623102;7110;7186.173590037212;6214.782482613267;6252.437280644764;6291;6330.936690633035;6370.58591191571;6361.459275961595;6374.617522948638;6455.193100862392;6459.224893012869;6467.126937863328;4657.324687920301;4657.767111644336;4785.330053792402;4789.233722604506;4790.712557246577;4805.951940480551;4862.854114376574;4962.230854217602;4972.129877271391;4972.602191824718 20:39:51 INFO - PROCESS | 8850 | |4;prototype.html;291.57575727316754;296.1352849678938;296.58181963431565;296.6069957306568;300.31528115895765;4734.952650473494;4764.165796168474;4768.141734487791;4774.522547745224;4798.904021919559;4689.296605509176;4713.316569097487;4725.1258517174265;4736.076465089301;4738.6446016548725;3574.303010912873;3606.1345277133432;3673.787650075482;3739.046543131511;3769.170782427875;3746.6440688134585;3755.6244375562496;3756.9060773480746;3761.0973366392004;3762.9435558466644;3556.857725690982;3738.943915841251;3749.962500375002;3754.924901501968;3756.924861502768;3615.7649752765988;3693.150575367667;3742.101895545077;3748.775073495599;3757.3236817372863;3298.5546951161764;3300.8019518828705;3306.768526203167;3308.1398836302733;3312.254742682901;4523.389342438794;4523.773811309455;4539.228331183706;4544.431946006749;4564.8402305919135;3892.727509074366;4190.643795277405;4203.810828512725;4212.7472351659;4235.618794308527;4882.41411030675;4909.165441874889;4926.507349265081;4930.482299358588;4969.850904472872;3470.785225171195;3481.5125882376487;3490.8080055596934;3504.404251277289;3516.138546056207;5002.524760147817;5119.897602047976;5154.329937108189;5158.303629010074;5173.379194496647;3549.6450354964295;3574.5889222739197;3581.9104522387147;3587.820608969541;3593.2633810068874;3619.366610843092;3620.402633565432;3628.401313783249;3630.909227269339;3637.181634132299;4169.812358443877;4172.269852775752;4173.373993900939;4178.12259425524;4178.247915375201;4713.74074425903;4969.875753106201;4973.5523802857915;4977.601791856643;4982.277569752366;1256.6292943581666;1259.817326487654;1268.6067319131098;1274.6749578857332;1276.6872116331558;805.118395357083;812.6911773526023;832.4339449174498;863.0937515608712;872.9476231426135;4422.557744225616;4424.646028317727;4430;4447.888802779892;4450.421445212101;5066.544011039025;5069.366329208849;5081.618878584047;5091.821786237464;5092.541671249605;4310.547392523803;4375.47494300686;4416.955830441719;4418.381426600278;4434.051355848324;2716.7419095185924;2720.6327145835453;2730.8530417224815;2734.3437574981863;2736.6590370718604;4756.500567440438;4767.067169585106;4781.832635857798;4863.2461968394955;4869.732164730903;5001.199808030698;5150.660828184699;5174.844754657366;5182.792688292426;5211.921821172686;4791.520847915181;4837.685550439211;4859.708417494961;4867.756612169377;4871.123197824426;5049.293098966221;5064.569511591556;5072.746362681777;5084.440711521804;5126.564242039469;4705;4960.429550601727;4971;4985.202367621163;4999.275105109666;4736.934189807266;4766.976165119152;4775.116603428377;4792.376990991149;4805.183118869731;3577.6422357764013;3601.1357274253464;3609.4766258892837;3614.548181477315;3619.529461170031;4790.449098353734;5006.624503162205;5009.296839074732;5011.699298041984;5019.322391477104;4883.902321953612;4892.608591312757;4898.4121905371585;4908.803647854046;4922.901541969069;4811.663183577256;4832.202686556679;4835.8635720606335;4837.685550439211;4908.852734417973;4638.721676699274;4715.976420118015;4786.893766742622;4808.2787581863;4810.182269014206;4747.64392670558;4886;4991.201407774739;5023.874403139951;5028.321176641107;4857.955539559011;4879.536444037811;4884.1941079722865;4899.730514821719;4912.477132089064 20:39:51 INFO - PROCESS | 8850 | |5;yui.html;702.5257950883156;709.1348554763188;733.640516147088;766.5592284436449;771.2018061306549;12413.751724965496;12902.225866447996;12977.48090076397;12979.870201297985;12998.54505092322;13171.934140329286;13225.20648761075;13229.073964822466;13242.271675057893;13308.334583270822;642.8939225027865;778.6262593954876;796.9203079692028;802.7912742686885;803.4135081390559;788.0503992688796;794.213728408874;794.3049831397499;794.3287921706149;794.5232860283842;831.5592735849979;841.8779277004861;842.2461896602537;842.2882664148784;842.7176895739934;667.8964760462087;826.4132465949183;834.586879494651;836.4270474724802;840.9831803363899;621.1986537366791;623.3610549187074;623.6569886562418;623.7692053940071;624.322609968185;12033.278003319741;12116.151869369147;12117.878821211763;12150.45322960469;12153.93923030388;11209.271397359227;11632.069434445224;11677.41612919359;11922.761544769057;12214.694632634166;11188.832167517494;11207.159463040223;11238.213325067249;11251.588468342792;11315.264507806965;4119.505659320871;4175.707700460969;4179.811908464127;4209.6421804146685;4299.527052024275;47077.764611176724;47223;47330.29004564969;47537;47570.52429475696;9328.95335523318;9844.3601165924;9872.997352241613;10033.949830250802;10159.288849780592;17007.574810629587;17085.231164597622;17311.65376692459;17369.56576085608;17370;6898.482613803984;6955.095837541087;6976.5814051157095;7056.082709247765;7086.610236437045;3747.3254814133716;3864.188520410689;3870.071182916136;3932.4297976793205;4062.0657248832936;2837.205582436921;2931.3844092740337;2934.1050979451047;2934.8679309431127;2935.4569404660206;514.0387475420987;527.7862465701397;533.2241588488739;548.5173047717983;549.2859282932172;393.4589938834103;418.9505289250408;491.9114559379274;584.141312270961;620.3982137326785;7715.382769378436;7905.881411778828;8022.759317220492;8128.309093727099;8206.302464290482;606.2058703098954;613.7084884679741;615.4522474997256;622.4180391334118;627.2285089340137;3251.317223383116;3331.7334613230882;3362.1930736623035;3404.4212483877304;3424.383610950003;53664.73167634137;55651.44348556543;56278;56336.71831640897;56595.15107273394;49930.50069499331;50649.24026139611;50779;51385;51849.48150518522;45743;45859.77070114628;46137.307940380924;46380.7680961593;46528.5347146531;7470;7487.8876816846705;7496.887546686913;7612.352949999312;7691.846163076819;31057;31718.682813171574;31841.522377164823;32240.67759322377;32505.837470812494;37930.81034594809;41286;41481.37777933273;41596.792016039726;42196.156076878906;9605.37565058269;9867.851982220416;9900.257480688833;9958.11262163071;9972.700818975442;10642.680719578426;10700.785984280115;11825.704357391134;11875.346855923008;12036.63890083299;11559.595414160463;11605.941970290094;11779.05767538612;11812.114091443003;12118.575849845212;11050.557977680803;11352.716182095513;11663.358515281741;11736.882631173921;11767.52929882795;9641.517924103626;10085.747856303651;10192.082712555906;11234.943825280821;11237.662870113909;9237.953810230905;9292.39599426035;9332.906670933475;9481;9595.328327017321;9037.548122593713;9376.343655944018;9412.717618471457;9447.763805904908;9458.33791634579 20:39:51 INFO - PROCESS | 8850 | __end_tp_report 20:39:51 INFO - PROCESS | 8850 | __start_cc_report 20:39:51 INFO - PROCESS | 8850 | _x_x_mozilla_cycle_collect,961 20:39:51 INFO - PROCESS | 8850 | __end_cc_report 20:39:51 INFO - PROCESS | 8850 | __startTimestamp1464147591497__endTimestamp 20:39:51 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | ------- Summary: start ------- 20:39:51 INFO - PROCESS | 8850 | Number of tests: 6 20:39:51 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | [#0] dojo.html Cycles:165 Average:4737.58 Median:4856.88 stddev:491.53 (10.1%) stddev-sans-first:465.69 20:39:51 INFO - PROCESS | 8850 | Values: 2676.8 2698.1 2721.3 2724.2 2756.3 4577.2 4649.0 4661.6 4761.8 4810.2 4706.6 4707.6 4779.9 4840.8 4853.0 4299.1 4350.8 4375.1 4406.2 4527.0 4437.0 4453.9 4478.3 4481.4 4517.4 4323.1 4366.1 4401.1 4411.3 4433.9 4347.3 4354.5 4364.8 4405.4 4407.4 4398.2 4399.6 4402.9 4441.5 4450.7 4577.8 4632.3 4680.3 4695.7 4743.6 5125.5 5140.8 5148.4 5157.9 5158.8 5139.3 5146.6 5169.1 5182.3 5183.7 4653.1 4809.2 4818.3 4861.9 4872.3 5249.1 5271.3 5271.8 5317.6 5332.3 4823.5 5064.6 5076.6 5077.5 5079.7 5096.7 5132.1 5138.5 5153.1 5173.4 5128.9 5138.7 5150.7 5155.3 5191.7 4900.5 5014.9 5129.6 5140.8 5143.0 4345.9 4357.3 4362.3 4407.1 4407.6 3777.9 3802.8 3811.1 3847.2 3847.4 4322.4 4371.4 4420.8 4435.7 4436.9 5171.1 5182.4 5203.9 5206.8 5259.7 4499.8 4508.5 4510.8 4517.5 4560.0 4550.0 4606.3 4635.9 4717.5 4748.7 4814.0 4831.9 4837.2 4877.6 4879.6 5132.5 5136.9 5140.6 5142.3 5142.9 4629.6 4745.8 4778.0 4789.8 4883.9 4995.6 5010.9 5011.0 5013.0 5013.1 5072.8 5079.9 5081.7 5082.5 5113.7 4881.6 4950.6 5004.5 5012.3 5025.1 4995.5 5029.4 5034.1 5035.7 5083.9 4768.9 4942.7 4963.4 4967.9 5015.2 4917.2 5016.7 5034.4 5046.2 5049.9 4856.9 4864.3 4904.7 4909.3 4912.8 20:39:51 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | [#1] ext.html Cycles:180 Average:49327.04 Median:38538.81 stddev:88089.16 (228.6%) stddev-sans-first:88260.28 20:39:51 INFO - PROCESS | 8850 | Values: 593.6 594.3 595.6 612.5 613.5 41004.2 42465.2 42652.4 46511.3 46573.3 43972.6 44581.8 44655.0 44746.6 44788.6 7657.2 7812.3 7877.6 7887.1 7889.8 7826.4 7910.0 7914.9 7921.0 7930.0 7892.4 7938.9 7954.2 7961.8 7963.1 7872.3 7914.8 7933.0 7941.1 7941.3 7718.3 7834.3 7853.6 7856.4 7856.7 40749.4 41104.8 41137.4 41195.8 41222.4 3278.4 3408.7 3555.0 3653.8 3766.9 30481.5 30807.8 30858.4 31470.5 32385.7 3505.3 3567.0 3588.2 3719.2 3723.9 278391.0 278819.0 278926.0 279940.0 279997.0 48107.0 49570.5 54724.0 55707.7 55734.0 47785.5 48223.5 48682.3 48981.0 49098.3 14521.6 14794.6 14829.6 14852.8 14877.7 10072.3 10852.6 11332.4 11461.9 11464.1 16211.3 16552.8 16678.6 16753.0 16896.7 6460.6 6580.0 6617.7 6698.9 6736.9 814.2 845.8 846.0 896.7 912.7 26636.9 28317.4 28859.6 28902.1 28908.6 989.6 1005.8 1033.8 1041.4 1057.6 14103.9 14594.6 14603.5 14842.6 14909.7 399865.0 401063.0 404553.0 404675.0 404944.0 50923.5 52289.5 52378.0 52397.7 52490.2 1084.3 1179.4 1202.4 1216.2 1240.5 28045.4 28806.6 29375.4 29475.7 29848.4 43059.8 43364.6 43867.3 43881.0 43915.8 307128.0 309548.0 311336.0 311943.0 312302.0 31220.4 37823.2 38661.0 38895.0 41938.6 43768.3 43883.0 44236.6 44657.3 44770.8 36321.0 36985.0 37040.6 37218.0 37584.6 37093.8 37396.6 37553.1 37753.2 37892.0 35782.6 36168.1 37519.8 38320.8 38416.6 32421.8 34060.1 34122.9 34427.5 34743.1 26136.9 26160.5 26268.5 26418.2 26555.6 20:39:51 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | [#2] jquery.html Cycles:180 Average:23501.73 Median:5086.39 stddev:62752.98 (1233.7%) stddev-sans-first:62904.94 20:39:51 INFO - PROCESS | 8850 | Values: 352.4 355.0 356.8 364.0 377.3 15775.4 16667.2 16966.6 16997.6 17262.4 16228.5 16606.7 17226.4 17259.6 17289.3 4921.2 5093.2 5096.3 5109.3 5116.4 3743.0 3898.1 5079.5 5508.5 5811.7 5801.2 5803.6 5838.8 5846.9 5849.4 5763.7 5783.8 5918.7 5920.8 5945.4 3375.7 4885.9 5177.5 5185.1 5188.0 20269.7 20801.6 20855.0 21114.8 21150.0 1897.5 1937.2 1965.8 2181.3 2388.7 8998.9 9313.8 9578.5 9727.7 12933.4 1734.7 1788.7 1817.6 1830.8 1832.5 71566.6 72013.3 72065.6 72812.0 73187.6 9917.2 10028.3 10169.5 10224.9 10505.3 14136.5 14345.0 14383.9 14389.1 14399.3 7212.9 7234.5 7266.7 7394.6 7504.1 6520.4 6715.8 6716.7 6728.4 6763.8 4418.1 4429.4 4444.2 4467.3 4491.6 1689.3 1766.5 1811.2 1861.0 1881.1 386.7 399.6 405.1 820.3 908.2 9893.8 10197.5 10248.8 10331.0 10530.1 416.4 424.1 429.2 431.3 437.5 5479.2 5523.3 5589.3 5631.8 5641.3 365668.0 371454.0 377793.0 385356.0 390338.0 78669.2 79089.6 79138.6 79142.2 80130.2 433.5 437.0 442.3 442.8 442.9 9913.5 9983.0 9991.0 10005.9 10058.8 29416.7 34174.5 34197.0 35864.0 36062.1 48771.3 51131.2 51643.7 52096.5 52268.0 7387.0 7397.6 7521.1 7531.5 7671.0 8360.8 9397.5 10990.0 10991.5 11312.3 9368.3 9827.4 9856.7 9864.8 9884.9 9601.2 9766.9 9773.3 9794.2 9935.7 9129.9 9618.3 9947.8 10048.7 10302.1 7395.6 7519.6 7523.5 7639.0 7721.5 9232.0 9244.0 9528.0 9566.3 9656.7 20:39:51 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | [#3] mootools.html Cycles:180 Average:5249.62 Median:4967.18 stddev:3004.43 (60.5%) stddev-sans-first:2997.64 20:39:51 INFO - PROCESS | 8850 | Values: 1225.4 1418.5 1442.2 1558.6 1778.8 6852.5 7745.8 7948.6 7954.1 8193.1 7968.9 8109.3 8112.6 8122.0 8125.6 1922.4 2141.4 2153.8 2171.0 2212.5 2211.8 2226.5 2231.8 2232.2 2239.0 2177.1 2197.4 2212.6 2215.0 2216.4 1841.7 2081.5 2139.7 2158.0 2165.0 2175.8 2176.8 2192.9 2195.5 2197.9 8116.0 8145.8 8153.3 8158.3 8164.1 4576.3 4752.2 4760.2 4763.8 4764.5 2893.3 2920.1 2967.4 3095.5 3097.3 910.2 917.1 924.5 935.1 952.2 11130.2 11136.6 11153.1 11180.8 11231.0 4077.9 4230.2 4298.5 4311.2 4320.4 9409.4 9452.2 9481.2 9484.4 9497.1 4646.1 4671.6 4694.5 4696.0 4696.4 3789.7 4185.7 4314.7 4315.2 4377.3 3660.6 3680.2 3750.5 3761.5 3781.5 1183.2 1187.2 1198.3 1203.2 1208.0 734.2 849.0 869.3 880.7 885.6 5179.8 5282.3 5400.2 5446.8 5458.0 389.4 391.1 402.9 406.3 409.5 3669.3 3733.7 3739.5 3766.1 3767.5 9603.4 9916.2 10014.4 10015.1 10020.0 9621.0 9763.0 9890.7 9911.5 9966.2 7485.4 7530.5 7575.3 7590.7 7617.4 5203.3 5296.5 5362.4 5419.5 5429.3 8981.5 9019.9 9215.1 9338.1 9367.7 9148.7 9338.7 9339.4 9420.5 9501.9 6213.4 6585.2 6787.5 6915.8 6989.9 7740.5 7743.1 7811.4 7812.2 7812.8 6851.3 6908.5 7062.3 7110.0 7186.2 6214.8 6252.4 6291.0 6330.9 6370.6 6361.5 6374.6 6455.2 6459.2 6467.1 4657.3 4657.8 4785.3 4789.2 4790.7 4806.0 4862.9 4962.2 4972.1 4972.6 20:39:51 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | [#4] prototype.html Cycles:180 Average:4102.15 Median:4720.55 stddev:1181.67 (25.0%) stddev-sans-first:1149.85 20:39:51 INFO - PROCESS | 8850 | Values: 291.6 296.1 296.6 296.6 300.3 4735.0 4764.2 4768.1 4774.5 4798.9 4689.3 4713.3 4725.1 4736.1 4738.6 3574.3 3606.1 3673.8 3739.0 3769.2 3746.6 3755.6 3756.9 3761.1 3762.9 3556.9 3738.9 3750.0 3754.9 3756.9 3615.8 3693.2 3742.1 3748.8 3757.3 3298.6 3300.8 3306.8 3308.1 3312.3 4523.4 4523.8 4539.2 4544.4 4564.8 3892.7 4190.6 4203.8 4212.7 4235.6 4882.4 4909.2 4926.5 4930.5 4969.9 3470.8 3481.5 3490.8 3504.4 3516.1 5002.5 5119.9 5154.3 5158.3 5173.4 3549.6 3574.6 3581.9 3587.8 3593.3 3619.4 3620.4 3628.4 3630.9 3637.2 4169.8 4172.3 4173.4 4178.1 4178.2 4713.7 4969.9 4973.6 4977.6 4982.3 1256.6 1259.8 1268.6 1274.7 1276.7 805.1 812.7 832.4 863.1 872.9 4422.6 4424.6 4430.0 4447.9 4450.4 5066.5 5069.4 5081.6 5091.8 5092.5 4310.5 4375.5 4417.0 4418.4 4434.1 2716.7 2720.6 2730.9 2734.3 2736.7 4756.5 4767.1 4781.8 4863.2 4869.7 5001.2 5150.7 5174.8 5182.8 5211.9 4791.5 4837.7 4859.7 4867.8 4871.1 5049.3 5064.6 5072.7 5084.4 5126.6 4705.0 4960.4 4971.0 4985.2 4999.3 4736.9 4767.0 4775.1 4792.4 4805.2 3577.6 3601.1 3609.5 3614.5 3619.5 4790.4 5006.6 5009.3 5011.7 5019.3 4883.9 4892.6 4898.4 4908.8 4922.9 4811.7 4832.2 4835.9 4837.7 4908.9 4638.7 4716.0 4786.9 4808.3 4810.2 4747.6 4886.0 4991.2 5023.9 5028.3 4858.0 4879.5 4884.2 4899.7 4912.5 20:39:51 INFO - PROCESS | 8850 | 20:39:51 INFO - PROCESS | 8850 | [#5] yui.html Cycles:180 Average:13278.34 Median:47433.65 stddev:15470.45 (32.6%) stddev-sans-first:15485.02 20:39:51 INFO - PROCESS | 8850 | Values: 702.5 709.1 733.6 766.6 771.2 12413.8 12902.2 12977.5 12979.9 12998.5 13171.9 13225.2 13229.1 13242.3 13308.3 642.9 778.6 796.9 802.8 803.4 788.1 794.2 794.3 794.3 794.5 831.6 841.9 842.2 842.3 842.7 667.9 826.4 834.6 836.4 841.0 621.2 623.4 623.7 623.8 624.3 12033.3 12116.2 12117.9 12150.5 12153.9 11209.3 11632.1 11677.4 11922.8 12214.7 11188.8 11207.2 11238.2 11251.6 11315.3 4119.5 4175.7 4179.8 4209.6 4299.5 47077.8 47223.0 47330.3 47537.0 47570.5 9329.0 9844.4 9873.0 10033.9 10159.3 17007.6 17085.2 17311.7 17369.6 17370.0 6898.5 6955.1 6976.6 7056.1 7086.6 3747.3 3864.2 3870.1 3932.4 4062.1 2837.2 2931.4 2934.1 2934.9 2935.5 514.0 527.8 533.2 548.5 549.3 393.5 419.0 491.9 584.1 620.4 7715.4 7905.9 8022.8 8128.3 8206.3 606.2 613.7 615.5 622.4 627.2 3251.3 3331.7 3362.2 3404.4 3424.4 53664.7 55651.4 56278.0 56336.7 56595.2 49930.5 50649.2 50779.0 51385.0 51849.5 45743.0 45859.8 46137.3 46380.8 46528.5 7470.0 7487.9 7496.9 7612.4 7691.8 31057.0 31718.7 31841.5 32240.7 32505.8 37930.8 41286.0 41481.4 41596.8 42196.2 9605.4 9867.9 9900.3 9958.1 9972.7 10642.7 10700.8 11825.7 11875.3 12036.6 11559.6 11605.9 11779.1 11812.1 12118.6 11050.6 11352.7 11663.4 11736.9 11767.5 9641.5 10085.7 10192.1 11234.9 11237.7 9238.0 9292.4 9332.9 9481.0 9595.3 9037.5 9376.3 9412.7 9447.8 9458.3 20:39:51 INFO - PROCESS | 8850 | -------- Summary: end -------- 20:39:51 INFO - PROCESS | 8850 | 20:39:52 INFO - TEST-INFO | 8850: exit 0 20:39:52 INFO - TEST-OK | dromaeo_css | took 1118787ms 20:39:52 INFO - TEST-START | kraken 20:39:52 INFO - operating with platform_type : linux_ 20:39:52 INFO - Initialising browser for kraken test... 20:39:52 INFO - TEST-INFO | started process 9024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmxgtH/profile http://localhost:35814/getInfo.html) 20:39:56 INFO - PROCESS | 9024 | __metrics Screen width/height:1600/1200 20:39:56 INFO - PROCESS | 9024 | colorDepth:24 20:39:56 INFO - PROCESS | 9024 | Browser inner width/height: 1024/697 20:39:56 INFO - PROCESS | 9024 | __metrics 20:39:57 ERROR - PROCESS | 9024 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:39:58 INFO - TEST-INFO | 9024: exit 0 20:39:58 INFO - Browser initialized. 20:39:58 INFO - Running cycle 1/1 for kraken test... 20:39:58 INFO - TEST-INFO | started process 9109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmxgtH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:40:10 INFO - PROCESS | 9109 | RSS: Main: 154845184 20:40:10 INFO - PROCESS | 9109 | 20:40:13 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35814/tests/kraken/driver.html?testName=audio-beat-detection) 20:40:14 INFO - PROCESS | 9109 | RSS: Main: 210358272 20:40:14 INFO - PROCESS | 9109 | 20:40:17 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35814/tests/kraken/driver.html?testName=audio-dft) 20:40:17 INFO - PROCESS | 9109 | RSS: Main: 197947392 20:40:17 INFO - PROCESS | 9109 | 20:40:20 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35814/tests/kraken/driver.html?testName=audio-fft) 20:40:21 INFO - PROCESS | 9109 | RSS: Main: 267169792 20:40:21 INFO - PROCESS | 9109 | 20:40:23 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35814/tests/kraken/driver.html?testName=audio-oscillator) 20:40:24 INFO - PROCESS | 9109 | RSS: Main: 176193536 20:40:24 INFO - PROCESS | 9109 | 20:40:26 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35814/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:40:27 INFO - PROCESS | 9109 | RSS: Main: 179744768 20:40:27 INFO - PROCESS | 9109 | 20:40:30 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35814/tests/kraken/driver.html?testName=imaging-darkroom) 20:40:30 INFO - PROCESS | 9109 | RSS: Main: 216260608 20:40:30 INFO - PROCESS | 9109 | 20:40:34 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35814/tests/kraken/driver.html?testName=imaging-desaturate) 20:40:35 INFO - PROCESS | 9109 | RSS: Main: 214163456 20:40:35 INFO - PROCESS | 9109 | 20:40:38 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35814/tests/kraken/driver.html?testName=json-parse-financial) 20:40:38 INFO - PROCESS | 9109 | RSS: Main: 215224320 20:40:38 INFO - PROCESS | 9109 | 20:40:40 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35814/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:40:40 INFO - PROCESS | 9109 | RSS: Main: 201457664 20:40:40 INFO - PROCESS | 9109 | 20:40:42 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35814/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:40:43 INFO - PROCESS | 9109 | RSS: Main: 207323136 20:40:43 INFO - PROCESS | 9109 | 20:40:45 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35814/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:40:46 INFO - PROCESS | 9109 | RSS: Main: 216961024 20:40:46 INFO - PROCESS | 9109 | 20:40:49 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:40:49 INFO - PROCESS | 9109 | RSS: Main: 222920704 20:40:49 INFO - PROCESS | 9109 | 20:40:52 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:40:53 INFO - PROCESS | 9109 | RSS: Main: 221331456 20:40:53 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | Cycle 1(1): loaded http://localhost:35814/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35814/tests/kraken/driver.html?testName=ai-astar) 20:40:55 INFO - PROCESS | 9109 | RSS: Main: 267198464 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | __start_tp_report 20:40:55 INFO - PROCESS | 9109 | _x_x_mozilla_page_load 20:40:55 INFO - PROCESS | 9109 | _x_x_mozilla_page_load_details 20:40:55 INFO - PROCESS | 9109 | |i|pagename|runs| 20:40:55 INFO - PROCESS | 9109 | |0;ai-astar;115;109;114;114;114;112;112;113;114;111 20:40:55 INFO - PROCESS | 9109 | |1;audio-beat-detection;156;129;131;178;130;131;163;128;168;129 20:40:55 INFO - PROCESS | 9109 | |2;audio-dft;162;160;162;163;162;161;161;160;163;162 20:40:55 INFO - PROCESS | 9109 | |3;audio-fft;76;76;76;100;76;76;77;77;99;76 20:40:55 INFO - PROCESS | 9109 | |4;audio-oscillator;86;84;121;85;86;85;113;84;84;127 20:40:55 INFO - PROCESS | 9109 | |5;imaging-gaussian-blur;116;116;117;116;117;116;117;117;116;117 20:40:55 INFO - PROCESS | 9109 | |6;imaging-darkroom;146;145;146;145;146;146;146;146;145;147 20:40:55 INFO - PROCESS | 9109 | |7;imaging-desaturate;94;95;95;95;95;95;95;94;95;95 20:40:55 INFO - PROCESS | 9109 | |8;json-parse-financial;63;64;64;63;65;63;64;80;62;62 20:40:55 INFO - PROCESS | 9109 | |9;json-stringify-tinderbox;64;65;65;65;66;65;65;66;66;67 20:40:55 INFO - PROCESS | 9109 | |10;stanford-crypto-aes;82;83;82;82;82;84;83;84;87;83 20:40:55 INFO - PROCESS | 9109 | |11;stanford-crypto-ccm;131;132;135;139;128;128;129;135;180;132 20:40:55 INFO - PROCESS | 9109 | |12;stanford-crypto-pbkdf2;174;175;168;174;167;174;169;167;168;172 20:40:55 INFO - PROCESS | 9109 | |13;stanford-crypto-sha256-iterative;74;67;67;65;67;64;66;65;66;64 20:40:55 INFO - PROCESS | 9109 | __end_tp_report 20:40:55 INFO - PROCESS | 9109 | __start_cc_report 20:40:55 INFO - PROCESS | 9109 | _x_x_mozilla_cycle_collect,1898 20:40:55 INFO - PROCESS | 9109 | __end_cc_report 20:40:55 INFO - PROCESS | 9109 | __startTimestamp1464147655290__endTimestamp 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | ------- Summary: start ------- 20:40:55 INFO - PROCESS | 9109 | Number of tests: 14 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.74 20:40:55 INFO - PROCESS | 9109 | Values: 115.0 109.0 114.0 114.0 114.0 112.0 112.0 113.0 114.0 111.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:143.50 stddev:19.65 (13.7%) stddev-sans-first:20.38 20:40:55 INFO - PROCESS | 9109 | Values: 156.0 129.0 131.0 178.0 130.0 131.0 163.0 128.0 168.0 129.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 20:40:55 INFO - PROCESS | 9109 | Values: 162.0 160.0 162.0 163.0 162.0 161.0 161.0 160.0 163.0 162.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:9.81 (12.9%) stddev-sans-first:10.25 20:40:55 INFO - PROCESS | 9109 | Values: 76.0 76.0 76.0 100.0 76.0 76.0 77.0 77.0 99.0 76.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.50 stddev:17.47 (20.7%) stddev-sans-first:18.19 20:40:55 INFO - PROCESS | 9109 | Values: 86.0 84.0 121.0 85.0 86.0 85.0 113.0 84.0 84.0 127.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:40:55 INFO - PROCESS | 9109 | Values: 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:40:55 INFO - PROCESS | 9109 | Values: 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 147.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 20:40:55 INFO - PROCESS | 9109 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.00 stddev:5.35 (8.4%) stddev-sans-first:5.63 20:40:55 INFO - PROCESS | 9109 | Values: 63.0 64.0 64.0 63.0 65.0 63.0 64.0 80.0 62.0 62.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 20:40:55 INFO - PROCESS | 9109 | Values: 64.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 66.0 67.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:1.55 (1.9%) stddev-sans-first:1.58 20:40:55 INFO - PROCESS | 9109 | Values: 82.0 83.0 82.0 82.0 82.0 84.0 83.0 84.0 87.0 83.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:133.50 stddev:15.54 (11.6%) stddev-sans-first:16.33 20:40:55 INFO - PROCESS | 9109 | Values: 131.0 132.0 135.0 139.0 128.0 128.0 129.0 135.0 180.0 132.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:173.00 stddev:3.29 (1.9%) stddev-sans-first:3.28 20:40:55 INFO - PROCESS | 9109 | Values: 174.0 175.0 168.0 174.0 167.0 174.0 169.0 167.0 168.0 172.0 20:40:55 INFO - PROCESS | 9109 | 20:40:55 INFO - PROCESS | 9109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:2.88 (4.3%) stddev-sans-first:1.22 20:40:55 INFO - PROCESS | 9109 | Values: 74.0 67.0 67.0 65.0 67.0 64.0 66.0 65.0 66.0 64.0 20:40:55 INFO - PROCESS | 9109 | -------- Summary: end -------- 20:40:55 INFO - PROCESS | 9109 | 20:40:56 INFO - TEST-INFO | 9109: exit 0 20:40:56 INFO - TEST-OK | kraken | took 64157ms 20:40:56 INFO - SUITE-END | took 1182s 20:40:56 INFO - Completed test suite (00:19:42) 20:40:56 INFO - javascript benchmark 20:40:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.772474339681, 2698.136596289188, 2721.3323770818397, 2724.209979106058, 2756.2971442282214, 4577.198990176722, 4648.9767551162195, 4661.557152070553, 4761.785719642611, 4810.206315957867, 4706.576408123268, 4707.576318131368, 4779.928301075487, 4840.830570930018, 4853.0, 4299.118680670455, 4350.80421381037, 4375.059362237118, 4406.184855801687, 4526.97736511317, 4437.0, 4453.88865278369, 4478.305862591287, 4481.439820022497, 4517.412736344287, 4323.070539833935, 4366.104948485553, 4401.053773438726, 4411.250087485135, 4433.889152771174, 4347.260965635849, 4354.542773008852, 4364.825406983717, 4405.427294451701, 4407.427034485529, 4398.186335527937, 4399.626031787302, 4402.933955990663, 4441.467023957113, 4450.710703804242, 4577.793999270041, 4632.328312394718, 4680.251159814447, 4695.67130300879, 4743.596794272491, 5125.487451254882, 5140.820071297524, 5148.382194136728, 5157.896842063175, 5158.845234642929, 5139.254808052849, 5146.614003949719, 5169.095408303532, 5182.300389447451, 5183.714895680736, 4653.139169253699, 4809.230523116355, 4818.253170758538, 4861.9027619447415, 4872.293517439952, 5249.081410753103, 5271.314729085195, 5271.815486458032, 5317.574594032545, 5332.280142180756, 4823.493533178966, 5064.569511591482, 5076.6446348755235, 5077.543021128116, 5079.6698214615935, 5096.719680417538, 5132.10188217068, 5138.486151384832, 5153.149730294459, 5173.3533308336455, 5128.948710512922, 5138.717370544656, 5150.742462876841, 5155.304033955443, 5191.740412979336, 4900.534449227318, 5014.899702006012, 5129.589632829439, 5140.845774626767, 5143.048536020848, 4345.9130817383475, 4357.346398040319, 4362.280223763044, 4407.052483715952, 4407.625351845065, 3777.9433308500393, 3802.8478860845257, 3811.123441608446, 3847.153626202231, 3847.3844184930276, 4322.37325587788, 4371.388005679208, 4420.756858372821, 4435.667324950641, 4436.933445998313, 5171.069207542603, 5182.4299327073995, 5203.869903252374, 5206.817761378334, 5259.684418934876, 4499.820007199741, 4508.458984921765, 4510.8421205257655, 4517.503074661785, 4560.0195957868555, 4549.954500455019, 4606.286025666027, 4635.860924172281, 4717.528247175255, 4748.738819364899, 4814.0, 4831.903361932671, 4837.153498137742, 4877.561019508332, 4879.609631229564, 5132.5124113209185, 5136.922946155736, 5140.640155189101, 5142.305788718475, 5142.922856157235, 4629.629629629554, 4745.833895813768, 4777.976110119427, 4789.760511974457, 4883.926741098958, 4995.62532810048, 5010.949890501049, 5010.974945125251, 5013.047520971004, 5013.147764880052, 5072.82245121419, 5079.9238011429115, 5081.72050537224, 5082.4917508250355, 5113.693178409308, 4881.633877459134, 4950.603951683928, 5004.524570165829, 5012.3233363495465, 5025.145725226794, 4995.525425084611, 5029.396472423333, 5034.0938631046765, 5035.748212589429, 5083.92374114396, 4768.928466072943, 4942.703437793743, 4963.379577552806, 4967.925481117713, 5015.172496538176, 4917.188663870565, 5016.724080175625, 5034.421041580265, 5046.1926091825135, 5049.899002019865, 4856.878578035577, 4864.294677271847, 4904.6566740327835, 4909.337239472626, 4912.778924948315], "value": 4706.858552158913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.5785592229514, 594.260146118083, 595.5711887441043, 612.5099920063954, 613.549041454531, 41004.179916401656, 42465.15069698604, 42652.36021459677, 46511.30233046498, 46573.30140047902, 43972.56027439725, 44581.77709111458, 44655.0, 44746.55253447464, 44788.55211447884, 7657.23427657234, 7812.3359514441345, 7877.606119694021, 7887.1324154343265, 7889.763307100796, 7826.413019023567, 7909.960450197741, 7914.920850791476, 7921.0, 7930.008748906387, 7892.368610511146, 7938.880916786253, 7954.244346787046, 7961.761147165595, 7963.084245311777, 7872.252136047066, 7914.762557123296, 7932.960335198345, 7941.086775020831, 7941.28528432441, 7718.266764657348, 7834.255745704149, 7853.5680537570415, 7856.371490280764, 7856.685732570691, 40749.388759168636, 41104.794476027426, 41137.382939255935, 41195.79402103, 41222.38166427506, 3278.393497203001, 3408.7102596279096, 3555.0, 3653.7807731535927, 3766.924661506782, 30481.542776858365, 30807.845960770275, 30858.382832343228, 31470.527942080887, 32385.676143238503, 3505.2814173094453, 3566.964330356689, 3588.174719814457, 3719.237556300952, 3723.8510459581585, 278391.0, 278819.0, 278926.0, 279940.0, 279997.0, 48107.0, 49570.50429495659, 54724.0, 55707.72146139244, 55734.0, 47785.52214477811, 48223.5177648219, 48682.26976595354, 48981.0, 49098.263526047136, 14521.636959076108, 14794.630134246514, 14829.555113346616, 14852.777208341884, 14877.702445951238, 10072.294939354322, 10852.620158294421, 11332.43337833105, 11461.942690286662, 11464.140189485655, 16211.27049282785, 16552.83447165537, 16678.58303542421, 16753.0, 16896.662066758596, 6460.612363258219, 6580.045893345438, 6617.702203400859, 6698.866022679519, 6736.922092465182, 814.2061490047157, 845.8308338332358, 845.9873101903477, 896.7040876510736, 912.7444315591645, 26636.866815666184, 28317.433651326857, 28859.567106493418, 28902.132936011953, 28908.566371504443, 989.6091044037565, 1005.788784355279, 1033.8035773203067, 1041.3595638682307, 1057.613970900631, 14103.884417337482, 14594.562163135122, 14603.517402041678, 14842.554723358317, 14909.701805964038, 399865.0, 401063.0, 404553.0, 404675.0, 404944.0, 50923.49076509262, 52289.47710522846, 52378.0, 52397.73801131046, 52490.21264681033, 1084.3168803653648, 1179.3690375648987, 1202.4348556178757, 1216.2398500936915, 1240.522398876421, 28045.439091218468, 28806.567901481914, 29375.412491750474, 29475.705242948156, 29848.403031939673, 43059.78470107629, 43364.566354337316, 43867.341989869536, 43881.0, 43915.78042109769, 307128.0, 309548.0, 311336.0, 311943.0, 312302.0, 31220.37559248757, 37823.243535129695, 38661.0, 38895.0, 41938.580614193466, 43768.343474847265, 43883.0, 44236.55763442325, 44657.33014004857, 44770.77614611906, 36321.0, 36985.0, 37040.6295937048, 37218.0, 37584.624153758115, 37093.81453092717, 37396.6260337404, 37553.06117347088, 37753.24493510169, 37892.0, 35782.64217357793, 36168.09579760527, 37519.812400938914, 38320.80839595896, 38416.6158338413, 32421.837890810395, 34060.14849628779, 34122.948406381576, 34427.4835877457, 34743.13142171466, 26136.8693156533, 26160.476790463705, 26268.474630507666, 26418.207453776417, 26555.60166597464], "value": 18152.04334262559, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.3991594331664, 354.9520814690016, 356.7681007345226, 363.99090022749414, 377.260569284203, 15775.368985240591, 16667.16664166793, 16966.575835604115, 16997.57506062349, 17262.395816146436, 16228.513144605651, 16606.66786664266, 17226.397076102337, 17259.568510787238, 17289.30842766288, 4921.212605983043, 5093.236014597822, 5096.286519887219, 5109.310243117169, 5116.437191908905, 3742.981285093571, 3898.142408670088, 5079.542841144296, 5508.476694713996, 5811.6803575803315, 5801.187833703285, 5803.593748437611, 5838.824835254949, 5846.853828654275, 5849.444302791228, 5763.654180749148, 5783.768649254025, 5918.704064796786, 5920.763169473216, 5945.405459454063, 3375.662433756629, 4885.926711099336, 5177.45636708144, 5185.066687996159, 5187.974060129675, 20269.695954560695, 20801.5839683207, 20855.0, 21114.788852111436, 21150.0, 1897.5161333859915, 1937.1960636335903, 1965.8329042031444, 2181.3237896252213, 2388.7014123234594, 8998.910010899872, 9313.813723725487, 9578.521073946344, 9727.708168754949, 12933.417996190099, 1734.6617409605133, 1788.7495750594926, 1817.5637846916777, 1830.7528483654803, 1832.5052235896367, 71566.64216678936, 72013.27986720118, 72065.6396718013, 72812.0, 73187.63406182989, 9917.206623470105, 10028.29801913859, 10169.491525423698, 10224.926382729855, 10505.264631475877, 14136.50522231717, 14345.0, 14383.928080359532, 14389.136651800925, 14399.280035998157, 7212.891806622905, 7234.457415693844, 7266.745663901844, 7394.593297368697, 7504.099508059068, 6520.445762110274, 6715.7985260442265, 6716.731330746716, 6728.394444500019, 6763.7632682855865, 4418.094290670405, 4429.357743127229, 4444.2222611042935, 4467.30756732707, 4491.595756381876, 1689.2820551265909, 1766.5406994181349, 1811.18360948726, 1860.9534761631066, 1881.0970734047735, 386.70610336144733, 399.60838378389343, 405.0824881643081, 820.2658620534588, 908.1826356279402, 9893.802123957481, 10197.541110650038, 10248.795024099625, 10331.0, 10530.10494107994, 416.44820612688306, 424.08186276711194, 429.2338176355191, 431.2862213037428, 437.4815843225788, 5479.205515200353, 5523.254360661259, 5589.345061096028, 5631.802886898939, 5641.266635337462, 365668.0, 371454.0, 377793.0, 385356.0, 390338.0, 78669.21330786619, 79089.60455197802, 79138.60430697925, 79142.20857791463, 80130.19869801344, 433.518794138506, 437.04723702329227, 442.28570858063995, 442.7763979190553, 442.92248856449993, 9913.504324783587, 9983.0, 9991.0, 10005.899941000496, 10058.798824023332, 29416.705832942254, 34174.487382689775, 34197.0, 35864.0, 36062.09844753902, 48771.268430974276, 51131.23303150381, 51643.74178129085, 52096.479035209166, 52268.0, 7387.0, 7397.556146631219, 7521.0974683038385, 7531.472796904164, 7671.0, 8360.83278334442, 9397.530123493661, 10990.0, 10991.505382257657, 11312.264702794291, 9368.25053995665, 9827.361221520578, 9856.704298871045, 9864.802703945737, 9884.851727223953, 9601.183899368632, 9766.853497197406, 9773.31586788918, 9794.216462682825, 9935.65225217114, 9129.863052054092, 9618.278629102706, 9947.801043978936, 10048.748781280527, 10302.072813446826, 7395.556266624019, 7519.586422746802, 7523.5109717870355, 7638.961805190938, 7721.53670779755, 9232.0, 9243.953780231055, 9527.952360238154, 9566.282528810507, 9656.662016829658], "value": 7425.981820746466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.4179264849192, 1418.4609848257664, 1442.2356151239842, 1558.6103474131467, 1778.7509748635193, 6852.5203235773515, 7745.767626971193, 7948.642311096, 7954.0852801927795, 8193.139720329369, 7968.920310796891, 8109.270165685087, 8112.634931428085, 8121.959390203056, 8125.553094579811, 1922.356010736398, 2141.357592722185, 2153.8061574458297, 2171.0338899189865, 2212.4911270407815, 2211.7677643847405, 2226.487907781211, 2231.7545070042283, 2232.151782322715, 2239.0, 2177.0856240379, 2197.373748481683, 2212.6459766437374, 2215.0475295622878, 2216.3794137641485, 1841.6961201401753, 2081.4805192209774, 2139.6683514055267, 2157.967630485544, 2165.0257384177185, 2175.8150557202657, 2176.836737244713, 2192.8684278943156, 2195.4730864592543, 2197.8900655169195, 8115.95942020292, 8145.796355091111, 8153.266206041485, 8158.306543943772, 8164.101948785629, 4576.336431217454, 4752.215884379073, 4760.190767569521, 4763.833265835679, 4764.499727528594, 2893.3489964757973, 2920.0801747449486, 2967.3768508613216, 3095.5356696495483, 3097.2876238465055, 910.1717437132178, 917.0554329041098, 924.4730503612943, 935.1069728409353, 952.1811242331589, 11130.220884538086, 11136.610218642309, 11153.051990580729, 11180.776384472347, 11230.999999999918, 4077.85727499542, 4230.238557059759, 4298.505671847715, 4311.223979683625, 4320.373545835836, 9409.38838975478, 9452.243820494345, 9481.194098501566, 9484.430934143973, 9497.050294970586, 4646.117237724821, 4671.649626278043, 4694.50707675696, 4696.03731235096, 4696.436427628638, 3789.6589306961955, 4185.727927684691, 4314.69797114199, 4315.1585440838735, 4377.277749171351, 3660.5607327120915, 3680.227152297994, 3750.5124333836425, 3761.5298087739034, 3781.489498917666, 1183.1838128472752, 1187.2460987273143, 1198.2630682130427, 1203.1638011582043, 1208.0275378320362, 734.2107234722695, 848.9957550212209, 869.3175856952262, 880.6961598248594, 885.5926273914072, 5179.81870634526, 5282.339707536558, 5400.162974738922, 5446.754896029688, 5457.972710136424, 389.44892976438024, 391.0907140897425, 402.9113595009093, 406.28088283737617, 409.4676920003983, 3669.3395188865725, 3733.6826369758874, 3739.457778622085, 3766.0584853786554, 3767.4913886625504, 9603.37578057424, 9916.206703463706, 10014.399136051714, 10015.148712359385, 10020.0, 9621.0, 9763.0, 9890.65382711616, 9911.454869982075, 9966.152877005536, 7485.438592105614, 7530.472866899374, 7575.280348366897, 7590.658420371096, 7617.390608751398, 5203.323567936144, 5296.549793267462, 5362.3833259174135, 5419.539339156216, 5429.294191755047, 8981.506017168856, 9019.909800901907, 9215.078492150731, 9338.112879276458, 9367.672131475365, 9148.725538233864, 9338.719838404859, 9339.392939458914, 9420.528973551433, 9501.857472137784, 6213.440790328892, 6585.242697089896, 6787.490938179558, 6915.78973679594, 6989.8951515726285, 7740.496867703581, 7743.070831500256, 7811.375089992901, 7812.1797211292, 7812.843743124992, 6851.280615535297, 6908.48186386013, 7062.293770623102, 7110.0, 7186.173590037212, 6214.782482613267, 6252.437280644764, 6291.0, 6330.936690633035, 6370.58591191571, 6361.459275961595, 6374.617522948638, 6455.193100862392, 6459.224893012869, 6467.126937863328, 4657.324687920301, 4657.767111644336, 4785.330053792402, 4789.233722604506, 4790.712557246577, 4805.951940480551, 4862.854114376574, 4962.230854217602, 4972.129877271391, 4972.602191824718], "value": 4127.231204177532, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.57575727316754, 296.1352849678938, 296.58181963431565, 296.6069957306568, 300.31528115895765, 4734.952650473494, 4764.165796168474, 4768.141734487791, 4774.522547745224, 4798.904021919559, 4689.296605509176, 4713.316569097487, 4725.1258517174265, 4736.076465089301, 4738.6446016548725, 3574.303010912873, 3606.1345277133432, 3673.787650075482, 3739.046543131511, 3769.170782427875, 3746.6440688134585, 3755.6244375562496, 3756.9060773480746, 3761.0973366392004, 3762.9435558466644, 3556.857725690982, 3738.943915841251, 3749.962500375002, 3754.924901501968, 3756.924861502768, 3615.7649752765988, 3693.150575367667, 3742.101895545077, 3748.775073495599, 3757.3236817372863, 3298.5546951161764, 3300.8019518828705, 3306.768526203167, 3308.1398836302733, 3312.254742682901, 4523.389342438794, 4523.773811309455, 4539.228331183706, 4544.431946006749, 4564.8402305919135, 3892.727509074366, 4190.643795277405, 4203.810828512725, 4212.7472351659, 4235.618794308527, 4882.41411030675, 4909.165441874889, 4926.507349265081, 4930.482299358588, 4969.850904472872, 3470.785225171195, 3481.5125882376487, 3490.8080055596934, 3504.404251277289, 3516.138546056207, 5002.524760147817, 5119.897602047976, 5154.329937108189, 5158.303629010074, 5173.379194496647, 3549.6450354964295, 3574.5889222739197, 3581.9104522387147, 3587.820608969541, 3593.2633810068874, 3619.366610843092, 3620.402633565432, 3628.401313783249, 3630.909227269339, 3637.181634132299, 4169.812358443877, 4172.269852775752, 4173.373993900939, 4178.12259425524, 4178.247915375201, 4713.74074425903, 4969.875753106201, 4973.5523802857915, 4977.601791856643, 4982.277569752366, 1256.6292943581666, 1259.817326487654, 1268.6067319131098, 1274.6749578857332, 1276.6872116331558, 805.118395357083, 812.6911773526023, 832.4339449174498, 863.0937515608712, 872.9476231426135, 4422.557744225616, 4424.646028317727, 4430.0, 4447.888802779892, 4450.421445212101, 5066.544011039025, 5069.366329208849, 5081.618878584047, 5091.821786237464, 5092.541671249605, 4310.547392523803, 4375.47494300686, 4416.955830441719, 4418.381426600278, 4434.051355848324, 2716.7419095185924, 2720.6327145835453, 2730.8530417224815, 2734.3437574981863, 2736.6590370718604, 4756.500567440438, 4767.067169585106, 4781.832635857798, 4863.2461968394955, 4869.732164730903, 5001.199808030698, 5150.660828184699, 5174.844754657366, 5182.792688292426, 5211.921821172686, 4791.520847915181, 4837.685550439211, 4859.708417494961, 4867.756612169377, 4871.123197824426, 5049.293098966221, 5064.569511591556, 5072.746362681777, 5084.440711521804, 5126.564242039469, 4705.0, 4960.429550601727, 4971.0, 4985.202367621163, 4999.275105109666, 4736.934189807266, 4766.976165119152, 4775.116603428377, 4792.376990991149, 4805.183118869731, 3577.6422357764013, 3601.1357274253464, 3609.4766258892837, 3614.548181477315, 3619.529461170031, 4790.449098353734, 5006.624503162205, 5009.296839074732, 5011.699298041984, 5019.322391477104, 4883.902321953612, 4892.608591312757, 4898.4121905371585, 4908.803647854046, 4922.901541969069, 4811.663183577256, 4832.202686556679, 4835.8635720606335, 4837.685550439211, 4908.852734417973, 4638.721676699274, 4715.976420118015, 4786.893766742622, 4808.2787581863, 4810.182269014206, 4747.64392670558, 4886.0, 4991.201407774739, 5023.874403139951, 5028.321176641107, 4857.955539559011, 4879.536444037811, 4884.1941079722865, 4899.730514821719, 4912.477132089064], "value": 3727.164388036556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.5257950883156, 709.1348554763188, 733.640516147088, 766.5592284436449, 771.2018061306549, 12413.751724965496, 12902.225866447996, 12977.48090076397, 12979.870201297985, 12998.54505092322, 13171.934140329286, 13225.20648761075, 13229.073964822466, 13242.271675057893, 13308.334583270822, 642.8939225027865, 778.6262593954876, 796.9203079692028, 802.7912742686885, 803.4135081390559, 788.0503992688796, 794.213728408874, 794.3049831397499, 794.3287921706149, 794.5232860283842, 831.5592735849979, 841.8779277004861, 842.2461896602537, 842.2882664148784, 842.7176895739934, 667.8964760462087, 826.4132465949183, 834.586879494651, 836.4270474724802, 840.9831803363899, 621.1986537366791, 623.3610549187074, 623.6569886562418, 623.7692053940071, 624.322609968185, 12033.278003319741, 12116.151869369147, 12117.878821211763, 12150.45322960469, 12153.93923030388, 11209.271397359227, 11632.069434445224, 11677.41612919359, 11922.761544769057, 12214.694632634166, 11188.832167517494, 11207.159463040223, 11238.213325067249, 11251.588468342792, 11315.264507806965, 4119.505659320871, 4175.707700460969, 4179.811908464127, 4209.6421804146685, 4299.527052024275, 47077.764611176724, 47223.0, 47330.29004564969, 47537.0, 47570.52429475696, 9328.95335523318, 9844.3601165924, 9872.997352241613, 10033.949830250802, 10159.288849780592, 17007.574810629587, 17085.231164597622, 17311.65376692459, 17369.56576085608, 17370.0, 6898.482613803984, 6955.095837541087, 6976.5814051157095, 7056.082709247765, 7086.610236437045, 3747.3254814133716, 3864.188520410689, 3870.071182916136, 3932.4297976793205, 4062.0657248832936, 2837.205582436921, 2931.3844092740337, 2934.1050979451047, 2934.8679309431127, 2935.4569404660206, 514.0387475420987, 527.7862465701397, 533.2241588488739, 548.5173047717983, 549.2859282932172, 393.4589938834103, 418.9505289250408, 491.9114559379274, 584.141312270961, 620.3982137326785, 7715.382769378436, 7905.881411778828, 8022.759317220492, 8128.309093727099, 8206.302464290482, 606.2058703098954, 613.7084884679741, 615.4522474997256, 622.4180391334118, 627.2285089340137, 3251.317223383116, 3331.7334613230882, 3362.1930736623035, 3404.4212483877304, 3424.383610950003, 53664.73167634137, 55651.44348556543, 56278.0, 56336.71831640897, 56595.15107273394, 49930.50069499331, 50649.24026139611, 50779.0, 51385.0, 51849.48150518522, 45743.0, 45859.77070114628, 46137.307940380924, 46380.7680961593, 46528.5347146531, 7470.0, 7487.8876816846705, 7496.887546686913, 7612.352949999312, 7691.846163076819, 31057.0, 31718.682813171574, 31841.522377164823, 32240.67759322377, 32505.837470812494, 37930.81034594809, 41286.0, 41481.37777933273, 41596.792016039726, 42196.156076878906, 9605.37565058269, 9867.851982220416, 9900.257480688833, 9958.11262163071, 9972.700818975442, 10642.680719578426, 10700.785984280115, 11825.704357391134, 11875.346855923008, 12036.63890083299, 11559.595414160463, 11605.941970290094, 11779.05767538612, 11812.114091443003, 12118.575849845212, 11050.557977680803, 11352.716182095513, 11663.358515281741, 11736.882631173921, 11767.52929882795, 9641.517924103626, 10085.747856303651, 10192.082712555906, 11234.943825280821, 11237.662870113909, 9237.953810230905, 9292.39599426035, 9332.906670933475, 9481.0, 9595.328327017321, 9037.548122593713, 9376.343655944018, 9412.717618471457, 9447.763805904908, 9458.33791634579], "value": 6011.65187474643, "unit": "score"}], "name": "dromaeo_css", "value": 6233.740605055544, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 114.0, 114.0, 112.0, 112.0, 113.0, 114.0, 111.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 131.0, 178.0, 130.0, 131.0, 163.0, 128.0, 168.0, 129.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 163.0, 162.0, 161.0, 161.0, 160.0, 163.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 100.0, 76.0, 76.0, 77.0, 77.0, 99.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 121.0, 85.0, 86.0, 85.0, 113.0, 84.0, 84.0, 127.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 65.0, 63.0, 64.0, 80.0, 62.0, 62.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 67.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 82.0, 82.0, 84.0, 83.0, 84.0, 87.0, 83.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 135.0, 139.0, 128.0, 128.0, 129.0, 135.0, 180.0, 132.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 168.0, 174.0, 167.0, 174.0, 169.0, 167.0, 168.0, 172.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 67.0, 67.0, 65.0, 67.0, 64.0, 66.0, 65.0, 66.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1540.0000000000002, "alertThreshold": 2.0}]} 20:40:56 INFO - Return code: 0 20:40:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:40:56 ERROR - # TBPL SUCCESS # 20:40:56 INFO - Running post-action listener: _resource_record_post_action 20:40:56 INFO - ##### 20:40:56 INFO - ##### Finished run-tests step (success) 20:40:56 INFO - ##### 20:40:56 INFO - Running post-run listener: _resource_record_post_run 20:40:56 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522022912; Read time: 16; Write time: 409864 20:40:56 INFO - TinderboxPrint: CPU usage
13.1% 20:40:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:40:56 INFO - TinderboxPrint: I/O write bytes / time
522,022,912 / 409,864 20:40:56 INFO - TinderboxPrint: CPU idle
8,326.0 (86.9%) 20:40:56 INFO - TinderboxPrint: CPU user
1,209.2 (12.6%) 20:40:56 INFO - TinderboxPrint: Swap in / out
0 / 0 20:40:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243568640; Read time: 0; Write time: 221388 20:40:56 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278454272; Read time: 16; Write time: 188476 20:40:57 INFO - Running post-run listener: _upload_blobber_files 20:40:57 INFO - Blob upload gear active. 20:40:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:40:57 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 20:40:57 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'] 20:40:57 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 20:40:57 INFO - (blobuploader) - INFO - Open directory for files ... 20:40:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:40:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:41:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:01 INFO - (blobuploader) - INFO - Done attempting. 20:41:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:41:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:41:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:02 INFO - (blobuploader) - INFO - Done attempting. 20:41:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:41:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:41:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:41:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:41:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:41:02 INFO - (blobuploader) - INFO - Done attempting. 20:41:02 INFO - (blobuploader) - INFO - Iteration through files over. 20:41:02 INFO - Return code: 0 20:41:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:41:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:41:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da1a5744f9b33e09e48a2e05c13348ef7ceee95d5ac696efb3fe4e2572ff36be388252b24de89b840b404599577e5f07c328e1831385b0fb2becaf4793ed4e58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56b4387a72635a183dd131600fe948ca40ee99ba80b471a96638236dc5a22ac244e7d3b757121d84e18ace093f0ac2f64cafa35fc69631bced8637f62cb91129", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d4ea3d8143be6ea7be6234199e60267b1bcfc2f67bbe33e83dbfff3e28602f531066e91bc34a57891708ed74eddf1c67777cacdbc02dbdaa4655679a4587c1fc"} 20:41:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:41:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:41:02 INFO - Contents: 20:41:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/da1a5744f9b33e09e48a2e05c13348ef7ceee95d5ac696efb3fe4e2572ff36be388252b24de89b840b404599577e5f07c328e1831385b0fb2becaf4793ed4e58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56b4387a72635a183dd131600fe948ca40ee99ba80b471a96638236dc5a22ac244e7d3b757121d84e18ace093f0ac2f64cafa35fc69631bced8637f62cb91129", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d4ea3d8143be6ea7be6234199e60267b1bcfc2f67bbe33e83dbfff3e28602f531066e91bc34a57891708ed74eddf1c67777cacdbc02dbdaa4655679a4587c1fc"} 20:41:02 INFO - Running post-run listener: copy_logs_to_upload_dir 20:41:02 INFO - Copying logs to upload dir... 20:41:02 INFO - mkdir: /builds/slave/test/build/upload/logs 20:41:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.398811 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-24 20:41:02.541152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:41:02.549159) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401 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/da1a5744f9b33e09e48a2e05c13348ef7ceee95d5ac696efb3fe4e2572ff36be388252b24de89b840b404599577e5f07c328e1831385b0fb2becaf4793ed4e58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56b4387a72635a183dd131600fe948ca40ee99ba80b471a96638236dc5a22ac244e7d3b757121d84e18ace093f0ac2f64cafa35fc69631bced8637f62cb91129", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d4ea3d8143be6ea7be6234199e60267b1bcfc2f67bbe33e83dbfff3e28602f531066e91bc34a57891708ed74eddf1c67777cacdbc02dbdaa4655679a4587c1fc"} build_url:https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/ASiwvGbSS0Wkl-73PVPA-g/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/da1a5744f9b33e09e48a2e05c13348ef7ceee95d5ac696efb3fe4e2572ff36be388252b24de89b840b404599577e5f07c328e1831385b0fb2becaf4793ed4e58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56b4387a72635a183dd131600fe948ca40ee99ba80b471a96638236dc5a22ac244e7d3b757121d84e18ace093f0ac2f64cafa35fc69631bced8637f62cb91129", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d4ea3d8143be6ea7be6234199e60267b1bcfc2f67bbe33e83dbfff3e28602f531066e91bc34a57891708ed74eddf1c67777cacdbc02dbdaa4655679a4587c1fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:41:02.577940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:41:02.578275) ========= 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=03627c79f6bb3d1578c4a402000001ba-1464146419.932715-704714401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:41:02.657833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:41:02.658152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:41:02.658483) ========= ========= Total master_lag: 0.19 =========