builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1464087249.91 results: success (0) buildid: 20160524032607 builduid: e2c3613582b84b5d9af2a8fe178ab921 revision: cf20e55e85503a971c3b01141ee6c8813fef505e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:09.906641) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:09.908009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:09.908355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:09.928388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:09.929125) ========= 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=ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 03:54:10-- 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% 67.1M=0s 2016-05-24 03:54:10 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099857 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.050289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.050651) ========= 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=ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019763 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.102402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.102859) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cf20e55e85503a971c3b01141ee6c8813fef505e --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 cf20e55e85503a971c3b01141ee6c8813fef505e --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=ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 03:54:10,298 truncating revision to first 12 chars 2016-05-24 03:54:10,298 Setting DEBUG logging. 2016-05-24 03:54:10,298 attempt 1/10 2016-05-24 03:54:10,298 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cf20e55e8550?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 03:54:10,523 unpacking tar archive at: fx-team-cf20e55e8550/testing/mozharness/ program finished with exit code 0 elapsedTime=0.499814 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.622897) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.623914) ========= script_repo_revision: cf20e55e85503a971c3b01141ee6c8813fef505e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.624697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.625035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 03:54:10.636287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-24 03:54:10.636625) ========= /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=ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:54:10 INFO - MultiFileLogger online at 20160524 03:54:10 in /builds/slave/test 03:54:10 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 03:54:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:54:10 INFO - {'append_to_log': False, 03:54:10 INFO - 'base_work_dir': '/builds/slave/test', 03:54:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:54:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:54:10 INFO - 'branch': 'Fx-Team-Non-PGO', 03:54:10 INFO - 'buildbot_json_path': 'buildprops.json', 03:54:10 INFO - 'config_files': ('talos/linux_config.py',), 03:54:10 INFO - 'default_actions': ('clobber', 03:54:10 INFO - 'read-buildbot-config', 03:54:10 INFO - 'download-and-extract', 03:54:10 INFO - 'populate-webroot', 03:54:10 INFO - 'create-virtualenv', 03:54:10 INFO - 'install', 03:54:10 INFO - 'run-tests'), 03:54:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:54:10 INFO - 'download_minidump_stackwalk': True, 03:54:10 INFO - 'download_symbols': 'ondemand', 03:54:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:54:10 INFO - 'tooltool.py': '/tools/tooltool.py', 03:54:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:54:10 INFO - '/tools/misc-python/virtualenv.py')}, 03:54:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:54:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:54:10 INFO - 'installer_path': 'installer.exe', 03:54:10 INFO - 'log_level': 'info', 03:54:10 INFO - 'log_name': 'talos', 03:54:10 INFO - 'log_to_console': True, 03:54:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:54:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:54:10 INFO - 'opt_config_files': (), 03:54:10 INFO - 'pip_index': False, 03:54:10 INFO - 'sps_profile': False, 03:54:10 INFO - 'sps_profile_interval': 0, 03:54:10 INFO - 'suite': 'dromaeojs', 03:54:10 INFO - 'system_bits': '32', 03:54:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:54:10 INFO - 'title': 'talos-linux64-ix-035', 03:54:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:54:10 INFO - 'use_talos_json': True, 03:54:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:54:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:54:10 INFO - 'work_dir': 'build'} 03:54:10 INFO - ##### 03:54:10 INFO - ##### Running clobber step. 03:54:10 INFO - ##### 03:54:10 INFO - Running pre-action listener: _resource_record_pre_action 03:54:10 INFO - Running main action method: clobber 03:54:10 INFO - rmtree: /builds/slave/test/build 03:54:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:54:11 INFO - Running post-action listener: _resource_record_post_action 03:54:11 INFO - ##### 03:54:11 INFO - ##### Finished clobber step (success) 03:54:11 INFO - ##### 03:54:11 INFO - ##### 03:54:11 INFO - ##### Running read-buildbot-config step. 03:54:11 INFO - ##### 03:54:11 INFO - Running pre-action listener: _resource_record_pre_action 03:54:11 INFO - Running main action method: read_buildbot_config 03:54:11 INFO - Using buildbot properties: 03:54:11 INFO - { 03:54:11 INFO - "project": "", 03:54:11 INFO - "product": "firefox", 03:54:11 INFO - "script_repo_revision": "production", 03:54:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:54:11 INFO - "repository": "", 03:54:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:54:11 INFO - "buildid": "20160524032607", 03:54:11 INFO - "pgo_build": "False", 03:54:11 INFO - "basedir": "/builds/slave/test", 03:54:11 INFO - "buildnumber": 1772, 03:54:11 INFO - "slavename": "talos-linux64-ix-035", 03:54:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:54:11 INFO - "platform": "ubuntu64_hw", 03:54:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:54:11 INFO - "branch": "fx-team", 03:54:11 INFO - "repo_path": "integration/fx-team", 03:54:11 INFO - "revision": "cf20e55e85503a971c3b01141ee6c8813fef505e", 03:54:11 INFO - "stage_platform": "linux64", 03:54:11 INFO - "builduid": "e2c3613582b84b5d9af2a8fe178ab921", 03:54:11 INFO - "slavebuilddir": "test" 03:54:11 INFO - } 03:54:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:54:11 INFO - Running post-action listener: _resource_record_post_action 03:54:11 INFO - ##### 03:54:11 INFO - ##### Finished read-buildbot-config step (success) 03:54:11 INFO - ##### 03:54:11 INFO - ##### 03:54:11 INFO - ##### Running download-and-extract step. 03:54:11 INFO - ##### 03:54:11 INFO - Running pre-action listener: _resource_record_pre_action 03:54:11 INFO - Running main action method: download_and_extract 03:54:11 INFO - mkdir: /builds/slave/test/build/tests 03:54:11 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')]} 03:54:11 INFO - https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:54:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:54:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:54:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:12 INFO - Downloaded 1361 bytes. 03:54:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:54:12 INFO - Using the following test package requirements: 03:54:12 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:54:12 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:54:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:54:12 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:54:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:54:12 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:54:12 INFO - u'jsshell-linux-x86_64.zip'], 03:54:12 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:54:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:54:12 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:54:12 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:54:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:54:12 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:54:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:54:12 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:54:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:54:12 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:54:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:54:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:54: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')]} 03:54:12 INFO - https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:54:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:54:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:54:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:14 INFO - Downloaded 22814446 bytes. 03:54:14 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'] 03:54:14 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 03:54:15 INFO - Return code: 0 03:54:15 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 03:54:15 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')]} 03:54:15 INFO - https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:54:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:54:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:54:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:33 INFO - Downloaded 22814446 bytes. 03:54:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:54:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:54:35 INFO - Return code: 0 03:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:35 INFO - https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:36 INFO - Downloaded 10840359 bytes. 03:54:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:54:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:54:36 INFO - Return code: 0 03:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:36 INFO - https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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 03:54:39 INFO - Downloaded 54814603 bytes. 03:54:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:54:39 INFO - mkdir: /builds/slave/test/properties 03:54:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:54:39 INFO - Writing to file /builds/slave/test/properties/build_url 03:54:39 INFO - Contents: 03:54:39 INFO - build_url:https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:54:40 INFO - Running post-action listener: _resource_record_post_action 03:54:40 INFO - Running post-action listener: set_extra_try_arguments 03:54:40 INFO - ##### 03:54:40 INFO - ##### Finished download-and-extract step (success) 03:54:40 INFO - ##### 03:54:40 INFO - ##### 03:54:40 INFO - ##### Running populate-webroot step. 03:54:40 INFO - ##### 03:54:40 INFO - Running pre-action listener: _resource_record_pre_action 03:54:40 INFO - Running main action method: populate_webroot 03:54:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:54:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:54:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:54:40 INFO - '--tppagecycles', 03:54:40 INFO - '7'], 03:54:40 INFO - 'tests': ['tsvgm']}}, 03:54:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:54:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:54:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:54:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:54:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:40 INFO - 'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:54:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:54:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:40 INFO - 'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['damp', 'tps']}, 03:54:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:40 INFO - 'tests': ['damp', 'tps']}, 03:54:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['dromaeo_dom']}, 03:54:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:54:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['a11yr', 03:54:40 INFO - 'ts_paint', 03:54:40 INFO - 'tpaint', 03:54:40 INFO - 'sessionrestore', 03:54:40 INFO - 'sessionrestore_no_auto_restore', 03:54:40 INFO - 'tabpaint']}, 03:54:40 INFO - 'other-e10s': {'tests': ['a11yr', 03:54:40 INFO - 'ts_paint', 03:54:40 INFO - 'tpaint', 03:54:40 INFO - 'sessionrestore', 03:54:40 INFO - 'sessionrestore_no_auto_restore', 03:54:40 INFO - 'tabpaint']}, 03:54:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:54:40 INFO - 'ts_paint', 03:54:40 INFO - 'tpaint', 03:54:40 INFO - 'sessionrestore', 03:54:40 INFO - 'sessionrestore_no_auto_restore', 03:54:40 INFO - 'tabpaint']}, 03:54:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:54:40 INFO - 'ts_paint', 03:54:40 INFO - 'tpaint', 03:54:40 INFO - 'sessionrestore', 03:54:40 INFO - 'sessionrestore_no_auto_restore', 03:54:40 INFO - 'tabpaint']}, 03:54:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['a11yr', 03:54:40 INFO - 'ts_paint', 03:54:40 INFO - 'tpaint', 03:54:40 INFO - 'sessionrestore', 03:54:40 INFO - 'sessionrestore_no_auto_restore', 03:54:40 INFO - 'tabpaint']}, 03:54:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['a11yr', 03:54:40 INFO - 'ts_paint', 03:54:40 INFO - 'tpaint', 03:54:40 INFO - 'sessionrestore', 03:54:40 INFO - 'sessionrestore_no_auto_restore', 03:54:40 INFO - 'tabpaint']}, 03:54:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['tsvgx', 03:54:40 INFO - 'tsvgr_opacity', 03:54:40 INFO - 'tart', 03:54:40 INFO - 'tscrollx', 03:54:40 INFO - 'cart']}, 03:54:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:54:40 INFO - 'tsvgr_opacity', 03:54:40 INFO - 'tart', 03:54:40 INFO - 'tscrollx', 03:54:40 INFO - 'cart']}, 03:54:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:40 INFO - 'talos_options': ['--disable-e10s'], 03:54:40 INFO - 'tests': ['tp5o']}, 03:54:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:40 INFO - 'tests': ['tp5o']}, 03:54:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:40 INFO - 'talos_options': ['--disable-e10s', 03:54:40 INFO - '--xperf_path', 03:54:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:54:40 INFO - 'tests': ['tp5n']}, 03:54:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:54:40 INFO - 'talos_options': ['--xperf_path', 03:54:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:54:40 INFO - 'tests': ['tp5n']}}, 03:54:40 INFO - 'talos.zip': {'path': '', 03:54:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:54:40 INFO - Running post-action listener: _resource_record_post_action 03:54:40 INFO - ##### 03:54:40 INFO - ##### Finished populate-webroot step (success) 03:54:40 INFO - ##### 03:54:40 INFO - ##### 03:54:40 INFO - ##### Running create-virtualenv step. 03:54:40 INFO - ##### 03:54:40 INFO - Running pre-action listener: _resource_record_pre_action 03:54:40 INFO - Running main action method: create_virtualenv 03:54:40 INFO - Creating virtualenv /builds/slave/test/build/venv 03:54:40 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 03:54:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:54:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:54:40 INFO - Using real prefix '/usr' 03:54:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:54:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:54:43 INFO - Installing pip.................done. 03:54:43 INFO - Return code: 0 03:54:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:54: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')]} 03:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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')]} 03:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:54:43 INFO - Using env: {'DISPLAY': ':0', 03:54:43 INFO - 'HOME': '/home/cltbld', 03:54:43 INFO - 'LANG': 'en_US.UTF-8', 03:54:43 INFO - 'LANGUAGE': 'en_US:en', 03:54:43 INFO - 'LOGNAME': 'cltbld', 03:54:43 INFO - 'MAIL': '/var/mail/cltbld', 03:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:43 INFO - 'MOZ_NO_REMOTE': '1', 03:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:43 INFO - 'NO_EM_RESTART': '1', 03:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:43 INFO - 'PWD': '/builds/slave/test', 03:54:43 INFO - 'SHELL': '/bin/bash', 03:54:43 INFO - 'SHLVL': '1', 03:54:43 INFO - 'TERM': 'linux', 03:54:43 INFO - 'TMOUT': '86400', 03:54:43 INFO - 'USER': 'cltbld', 03:54:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:43 INFO - '_': '/tools/buildbot/bin/python'} 03:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:43 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 03:54:43 INFO - Cleaning up... 03:54:43 INFO - Return code: 0 03:54:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:54: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')]} 03:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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')]} 03:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:54:43 INFO - Using env: {'DISPLAY': ':0', 03:54:43 INFO - 'HOME': '/home/cltbld', 03:54:43 INFO - 'LANG': 'en_US.UTF-8', 03:54:43 INFO - 'LANGUAGE': 'en_US:en', 03:54:43 INFO - 'LOGNAME': 'cltbld', 03:54:43 INFO - 'MAIL': '/var/mail/cltbld', 03:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:43 INFO - 'MOZ_NO_REMOTE': '1', 03:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:43 INFO - 'NO_EM_RESTART': '1', 03:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:43 INFO - 'PWD': '/builds/slave/test', 03:54:43 INFO - 'SHELL': '/bin/bash', 03:54:43 INFO - 'SHLVL': '1', 03:54:43 INFO - 'TERM': 'linux', 03:54:43 INFO - 'TMOUT': '86400', 03:54:43 INFO - 'USER': 'cltbld', 03:54:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:43 INFO - '_': '/tools/buildbot/bin/python'} 03:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:43 INFO - Downloading/unpacking psutil>=3.1.1 03:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:54:45 INFO - Installing collected packages: psutil 03:54:45 INFO - Running setup.py install for psutil 03:54:45 INFO - building 'psutil._psutil_linux' extension 03:54:45 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 03:54:45 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 03:54:45 INFO - building 'psutil._psutil_posix' extension 03:54:45 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 03:54:45 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 03:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:54:45 INFO - Successfully installed psutil 03:54:45 INFO - Cleaning up... 03:54:46 INFO - Return code: 0 03:54:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:54: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')]} 03:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54: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')]} 03:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:54:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:54:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:54:46 INFO - Using env: {'DISPLAY': ':0', 03:54:46 INFO - 'HOME': '/home/cltbld', 03:54:46 INFO - 'LANG': 'en_US.UTF-8', 03:54:46 INFO - 'LANGUAGE': 'en_US:en', 03:54:46 INFO - 'LOGNAME': 'cltbld', 03:54:46 INFO - 'MAIL': '/var/mail/cltbld', 03:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:46 INFO - 'MOZ_NO_REMOTE': '1', 03:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:46 INFO - 'NO_EM_RESTART': '1', 03:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:46 INFO - 'PWD': '/builds/slave/test', 03:54:46 INFO - 'SHELL': '/bin/bash', 03:54:46 INFO - 'SHLVL': '1', 03:54:46 INFO - 'TERM': 'linux', 03:54:46 INFO - 'TMOUT': '86400', 03:54:46 INFO - 'USER': 'cltbld', 03:54:46 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:46 INFO - '_': '/tools/buildbot/bin/python'} 03:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:54:48 INFO - Installing collected packages: mozsystemmonitor 03:54:48 INFO - Running setup.py install for mozsystemmonitor 03:54:48 INFO - Successfully installed mozsystemmonitor 03:54:48 INFO - Cleaning up... 03:54:48 INFO - Return code: 0 03:54:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:48 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 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:54:48 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 03:54:48 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 03:54:48 INFO - Using env: {'DISPLAY': ':0', 03:54:48 INFO - 'HOME': '/home/cltbld', 03:54:48 INFO - 'LANG': 'en_US.UTF-8', 03:54:48 INFO - 'LANGUAGE': 'en_US:en', 03:54:48 INFO - 'LOGNAME': 'cltbld', 03:54:48 INFO - 'MAIL': '/var/mail/cltbld', 03:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:48 INFO - 'MOZ_NO_REMOTE': '1', 03:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:48 INFO - 'NO_EM_RESTART': '1', 03:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:48 INFO - 'PWD': '/builds/slave/test', 03:54:48 INFO - 'SHELL': '/bin/bash', 03:54:48 INFO - 'SHLVL': '1', 03:54:48 INFO - 'TERM': 'linux', 03:54:48 INFO - 'TMOUT': '86400', 03:54:48 INFO - 'USER': 'cltbld', 03:54:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:48 INFO - '_': '/tools/buildbot/bin/python'} 03:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:54:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:54: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 03:54: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 03:54: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 03:54: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 03:54: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 03:54: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 03:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:54:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:54: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 03:54: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 03:54: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 03:54: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 03:54: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 03:54: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 03:54:51 INFO - Downloading docopt-0.6.1.tar.gz 03:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:54:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:54:51 INFO - Running setup.py install for blobuploader 03:54:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:54:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:54:51 INFO - Running setup.py install for requests 03:54:51 INFO - Running setup.py install for docopt 03:54:51 INFO - Successfully installed blobuploader requests docopt 03:54:51 INFO - Cleaning up... 03:54:51 INFO - Return code: 0 03:54:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:51 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 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:54:51 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 03:54:51 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 03:54:51 INFO - Using env: {'DISPLAY': ':0', 03:54:51 INFO - 'HOME': '/home/cltbld', 03:54:51 INFO - 'LANG': 'en_US.UTF-8', 03:54:51 INFO - 'LANGUAGE': 'en_US:en', 03:54:51 INFO - 'LOGNAME': 'cltbld', 03:54:51 INFO - 'MAIL': '/var/mail/cltbld', 03:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:51 INFO - 'MOZ_NO_REMOTE': '1', 03:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:51 INFO - 'NO_EM_RESTART': '1', 03:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:51 INFO - 'PWD': '/builds/slave/test', 03:54:51 INFO - 'SHELL': '/bin/bash', 03:54:51 INFO - 'SHLVL': '1', 03:54:51 INFO - 'TERM': 'linux', 03:54:51 INFO - 'TMOUT': '86400', 03:54:51 INFO - 'USER': 'cltbld', 03:54:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:51 INFO - '_': '/tools/buildbot/bin/python'} 03:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:52 INFO - Running setup.py (path:/tmp/pip-xe5jrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:52 INFO - Running setup.py (path:/tmp/pip-anZqzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:52 INFO - Running setup.py (path:/tmp/pip-_tuY4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:52 INFO - Running setup.py (path:/tmp/pip-BOug87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:52 INFO - Running setup.py (path:/tmp/pip-kOPqVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:52 INFO - Running setup.py (path:/tmp/pip-RfOlWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:52 INFO - Running setup.py (path:/tmp/pip-LFgPXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:52 INFO - Running setup.py (path:/tmp/pip-NM9FXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:52 INFO - Running setup.py (path:/tmp/pip-MlBdFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:52 INFO - Running setup.py (path:/tmp/pip-sjm6OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:52 INFO - Running setup.py (path:/tmp/pip-6UeeiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:52 INFO - Running setup.py (path:/tmp/pip-EUGbvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:52 INFO - Running setup.py (path:/tmp/pip-vLzaPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:52 INFO - Running setup.py (path:/tmp/pip-Z8vKVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:53 INFO - Running setup.py (path:/tmp/pip-gpq_Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:53 INFO - Running setup.py (path:/tmp/pip-k3ujMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:53 INFO - Running setup.py (path:/tmp/pip-YUpdyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:54:53 INFO - Running setup.py install for manifestparser 03:54:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:54:53 INFO - Running setup.py install for mozcrash 03:54:53 INFO - Running setup.py install for mozdebug 03:54:53 INFO - Running setup.py install for mozdevice 03:54:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:54:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:54:53 INFO - Running setup.py install for mozfile 03:54:53 INFO - Running setup.py install for mozhttpd 03:54:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:54:53 INFO - Running setup.py install for mozinfo 03:54:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:54:53 INFO - Running setup.py install for mozInstall 03:54:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Running setup.py install for mozleak 03:54:54 INFO - Running setup.py install for mozlog 03:54:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Running setup.py install for moznetwork 03:54:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Running setup.py install for mozprocess 03:54:54 INFO - Running setup.py install for mozprofile 03:54:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Running setup.py install for mozrunner 03:54:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:54:54 INFO - Running setup.py install for mozscreenshot 03:54:54 INFO - Running setup.py install for moztest 03:54:54 INFO - Running setup.py install for mozversion 03:54:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:54:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:54:55 INFO - Cleaning up... 03:54:55 INFO - Return code: 0 03:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:55 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 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:54:55 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 03:54:55 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 03:54:55 INFO - Using env: {'DISPLAY': ':0', 03:54:55 INFO - 'HOME': '/home/cltbld', 03:54:55 INFO - 'LANG': 'en_US.UTF-8', 03:54:55 INFO - 'LANGUAGE': 'en_US:en', 03:54:55 INFO - 'LOGNAME': 'cltbld', 03:54:55 INFO - 'MAIL': '/var/mail/cltbld', 03:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:55 INFO - 'MOZ_NO_REMOTE': '1', 03:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:55 INFO - 'NO_EM_RESTART': '1', 03:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:55 INFO - 'PWD': '/builds/slave/test', 03:54:55 INFO - 'SHELL': '/bin/bash', 03:54:55 INFO - 'SHLVL': '1', 03:54:55 INFO - 'TERM': 'linux', 03:54:55 INFO - 'TMOUT': '86400', 03:54:55 INFO - 'USER': 'cltbld', 03:54:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:55 INFO - '_': '/tools/buildbot/bin/python'} 03:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:55 INFO - Running setup.py (path:/tmp/pip-Mseuwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:55 INFO - Running setup.py (path:/tmp/pip-_Y7dWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:55 INFO - Running setup.py (path:/tmp/pip-J5Pt2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:55 INFO - Running setup.py (path:/tmp/pip-_PscVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:55 INFO - Running setup.py (path:/tmp/pip-FL0K0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:55 INFO - Running setup.py (path:/tmp/pip-ZGv2b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:55 INFO - Running setup.py (path:/tmp/pip-I26QzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:55 INFO - Running setup.py (path:/tmp/pip-TAJhgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:55 INFO - Running setup.py (path:/tmp/pip-LzJiFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:55 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)) 03:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:55 INFO - Running setup.py (path:/tmp/pip-eJGjHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:56 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)) 03:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:56 INFO - Running setup.py (path:/tmp/pip-T8tCkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:56 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)) 03:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:56 INFO - Running setup.py (path:/tmp/pip-ZOHAWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:56 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)) 03:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:56 INFO - Running setup.py (path:/tmp/pip-wNJ4F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:56 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)) 03:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:56 INFO - Running setup.py (path:/tmp/pip-SNjH3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:56 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)) 03:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:56 INFO - Running setup.py (path:/tmp/pip-44N3HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:56 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)) 03:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:56 INFO - Running setup.py (path:/tmp/pip-4gJx3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:56 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)) 03:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:56 INFO - Running setup.py (path:/tmp/pip-26HlTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:56 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)) 03:54:56 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)) 03:54:56 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)) 03:54:56 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)) 03:54:56 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)) 03:54:56 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)) 03:54:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:54:56 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 03:54:56 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 03:54:56 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 03:54:56 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 03:54:56 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 03:54:56 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 03:54:58 INFO - Downloading blessings-1.6.tar.gz 03:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:54:58 INFO - Installing collected packages: blessings 03:54:58 INFO - Running setup.py install for blessings 03:54:58 INFO - Successfully installed blessings 03:54:58 INFO - Cleaning up... 03:54:58 INFO - Return code: 0 03:54:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:58 INFO - Reading from file tmpfile_stdout 03:54:58 INFO - Current package versions: 03:54:58 INFO - argparse == 1.2.1 03:54:58 INFO - blessings == 1.6 03:54:58 INFO - blobuploader == 1.2.4 03:54:58 INFO - docopt == 0.6.1 03:54:58 INFO - manifestparser == 1.1 03:54:58 INFO - mozInstall == 1.12 03:54:58 INFO - mozcrash == 0.17 03:54:58 INFO - mozdebug == 0.1 03:54:58 INFO - mozdevice == 0.48 03:54:58 INFO - mozfile == 1.2 03:54:58 INFO - mozhttpd == 0.7 03:54:58 INFO - mozinfo == 0.9 03:54:58 INFO - mozleak == 0.1 03:54:58 INFO - mozlog == 3.2 03:54:58 INFO - moznetwork == 0.27 03:54:58 INFO - mozprocess == 0.22 03:54:58 INFO - mozprofile == 0.28 03:54:58 INFO - mozrunner == 6.11 03:54:58 INFO - mozscreenshot == 0.1 03:54:58 INFO - mozsystemmonitor == 0.3 03:54:58 INFO - moztest == 0.7 03:54:58 INFO - mozversion == 1.4 03:54:58 INFO - psutil == 3.1.1 03:54:58 INFO - requests == 1.2.3 03:54:58 INFO - wsgiref == 0.1.2 03:54:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:58 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 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:54:58 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 03:54:58 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 03:54:58 INFO - Using env: {'DISPLAY': ':0', 03:54:58 INFO - 'HOME': '/home/cltbld', 03:54:58 INFO - 'LANG': 'en_US.UTF-8', 03:54:58 INFO - 'LANGUAGE': 'en_US:en', 03:54:58 INFO - 'LOGNAME': 'cltbld', 03:54:58 INFO - 'MAIL': '/var/mail/cltbld', 03:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:58 INFO - 'MOZ_NO_REMOTE': '1', 03:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:58 INFO - 'NO_EM_RESTART': '1', 03:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:58 INFO - 'PWD': '/builds/slave/test', 03:54:58 INFO - 'SHELL': '/bin/bash', 03:54:58 INFO - 'SHLVL': '1', 03:54:58 INFO - 'TERM': 'linux', 03:54:58 INFO - 'TMOUT': '86400', 03:54:58 INFO - 'USER': 'cltbld', 03:54:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:58 INFO - '_': '/tools/buildbot/bin/python'} 03:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 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)) 03:54:59 INFO - Cleaning up... 03:54:59 INFO - Return code: 0 03:54:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:54:59 INFO - Using env: {'DISPLAY': ':0', 03:54:59 INFO - 'HOME': '/home/cltbld', 03:54:59 INFO - 'LANG': 'en_US.UTF-8', 03:54:59 INFO - 'LANGUAGE': 'en_US:en', 03:54:59 INFO - 'LOGNAME': 'cltbld', 03:54:59 INFO - 'MAIL': '/var/mail/cltbld', 03:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:59 INFO - 'MOZ_NO_REMOTE': '1', 03:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:59 INFO - 'NO_EM_RESTART': '1', 03:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:59 INFO - 'PWD': '/builds/slave/test', 03:54:59 INFO - 'SHELL': '/bin/bash', 03:54:59 INFO - 'SHLVL': '1', 03:54:59 INFO - 'TERM': 'linux', 03:54:59 INFO - 'TMOUT': '86400', 03:54:59 INFO - 'USER': 'cltbld', 03:54:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:59 INFO - '_': '/tools/buildbot/bin/python'} 03:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:59 INFO - Downloading/unpacking jsonschema 03:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:55:01 INFO - Downloading/unpacking functools32 (from jsonschema) 03:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:55:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:55:01 INFO - warning: no files found matching '*.txt' 03:55:01 INFO - no previously-included directories found matching 'build' 03:55:01 INFO - no previously-included directories found matching 'dist' 03:55:01 INFO - no previously-included directories found matching '.git*' 03:55:01 INFO - Installing collected packages: jsonschema, functools32 03:55:01 INFO - Running setup.py install for functools32 03:55:01 INFO - warning: no files found matching '*.txt' 03:55:01 INFO - no previously-included directories found matching 'build' 03:55:01 INFO - no previously-included directories found matching 'dist' 03:55:01 INFO - no previously-included directories found matching '.git*' 03:55:01 INFO - Successfully installed jsonschema functools32 03:55:01 INFO - Cleaning up... 03:55:01 INFO - Return code: 0 03:55:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:55:01 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')]} 03:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:01 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')]} 03:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:01 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 0x7f3d529faf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ff770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', '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 03:55:01 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 03:55:01 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 03:55:01 INFO - Using env: {'DISPLAY': ':0', 03:55:01 INFO - 'HOME': '/home/cltbld', 03:55:01 INFO - 'LANG': 'en_US.UTF-8', 03:55:01 INFO - 'LANGUAGE': 'en_US:en', 03:55:01 INFO - 'LOGNAME': 'cltbld', 03:55:01 INFO - 'MAIL': '/var/mail/cltbld', 03:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:01 INFO - 'MOZ_NO_REMOTE': '1', 03:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:01 INFO - 'NO_EM_RESTART': '1', 03:55:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:01 INFO - 'PWD': '/builds/slave/test', 03:55:01 INFO - 'SHELL': '/bin/bash', 03:55:01 INFO - 'SHLVL': '1', 03:55:01 INFO - 'TERM': 'linux', 03:55:01 INFO - 'TMOUT': '86400', 03:55:01 INFO - 'USER': 'cltbld', 03:55:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:01 INFO - '_': '/tools/buildbot/bin/python'} 03:55:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:01 INFO - Downloading/unpacking flake8 03:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:55:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:55:03 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 03:55:03 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 03:55:03 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 03:55:03 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 03:55:03 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 03:55:03 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 03:55:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:55:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 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 03:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:55:04 INFO - no previously-included directories found matching 'docs/_build' 03:55:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:55:04 INFO - Running setup.py install for pep8 03:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:55:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:55:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:55:04 INFO - no previously-included directories found matching 'docs/_build' 03:55:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:55:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:55:04 INFO - Cleaning up... 03:55:04 INFO - Return code: 0 03:55:04 INFO - Running post-action listener: _resource_record_post_action 03:55:04 INFO - Running post-action listener: _start_resource_monitoring 03:55:04 INFO - Starting resource monitoring. 03:55:04 INFO - ##### 03:55:04 INFO - ##### Finished create-virtualenv step (success) 03:55:04 INFO - ##### 03:55:04 INFO - ##### 03:55:04 INFO - ##### Running install step. 03:55:04 INFO - ##### 03:55:04 INFO - Running pre-action listener: _resource_record_pre_action 03:55:04 INFO - Running main action method: install 03:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:05 INFO - Reading from file tmpfile_stdout 03:55:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:55:05 INFO - Reading from file tmpfile_stdout 03:55:05 INFO - Output received: 03:55:05 INFO - Usage: mozinstall [options] installer 03:55:05 INFO - Options: 03:55:05 INFO - -h, --help show this help message and exit 03:55:05 INFO - -d DEST, --destination=DEST 03:55:05 INFO - Directory to install application into. [default: 03:55:05 INFO - "/builds/slave/test"] 03:55:05 INFO - --app=APP Application being installed. [default: firefox] 03:55:05 INFO - mkdir: /builds/slave/test/build/application 03:55:05 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'] 03:55:05 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 03:55:20 INFO - Reading from file tmpfile_stdout 03:55:20 INFO - Output received: 03:55:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:55:20 INFO - Running post-action listener: _resource_record_post_action 03:55:20 INFO - ##### 03:55:20 INFO - ##### Finished install step (success) 03:55:20 INFO - ##### 03:55:20 INFO - ##### 03:55:20 INFO - ##### Running run-tests step. 03:55:20 INFO - ##### 03:55:20 INFO - Running pre-action listener: _resource_record_pre_action 03:55:20 INFO - Running main action method: run_tests 03:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:55:20 INFO - Python 2.7.3 03:55:20 INFO - Return code: 0 03:55:20 INFO - grabbing minidump binary from tooltool 03:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:55:20 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 0x158e9c0>, '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 0x158f8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158fd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:55:20 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 03:55:20 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 03:55:20 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 03:55:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:55:20 INFO - Return code: 0 03:55:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:55:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:55:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:55:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:55:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:55:21 INFO - Return code: 0 03:55:21 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/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 03:55:21 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/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 03:55:21 INFO - Using env: {'DISPLAY': ':0', 03:55:21 INFO - 'HOME': '/home/cltbld', 03:55:21 INFO - 'LANG': 'en_US.UTF-8', 03:55:21 INFO - 'LANGUAGE': 'en_US:en', 03:55:21 INFO - 'LOGNAME': 'cltbld', 03:55:21 INFO - 'MAIL': '/var/mail/cltbld', 03:55:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:55:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:21 INFO - 'MOZ_NO_REMOTE': '1', 03:55:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:21 INFO - 'NO_EM_RESTART': '1', 03:55:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:21 INFO - 'PWD': '/builds/slave/test', 03:55:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:55:21 INFO - 'SHELL': '/bin/bash', 03:55:21 INFO - 'SHLVL': '1', 03:55:21 INFO - 'TERM': 'linux', 03:55:21 INFO - 'TMOUT': '86400', 03:55:21 INFO - 'USER': 'cltbld', 03:55:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675', 03:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:21 INFO - '_': '/tools/buildbot/bin/python'} 03:55:21 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/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 03:55:22 INFO - mozversion application_buildid: 20160524032607 03:55:22 INFO - mozversion application_changeset: cf20e55e85503a971c3b01141ee6c8813fef505e 03:55:22 INFO - mozversion application_display_name: Nightly 03:55:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:55:22 INFO - mozversion application_name: Firefox 03:55:22 INFO - mozversion application_remotingname: firefox 03:55:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:55:22 INFO - mozversion application_vendor: Mozilla 03:55:22 INFO - mozversion application_version: 49.0a1 03:55:22 INFO - mozversion platform_buildid: 20160524032607 03:55:22 INFO - mozversion platform_changeset: cf20e55e85503a971c3b01141ee6c8813fef505e 03:55:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:55:22 INFO - mozversion platform_version: 49.0a1 03:55:22 INFO - using testdate: 1464087322 03:55:22 INFO - actual date: 1464087322 03:55:22 INFO - starting webserver on 'localhost:58695' 03:55:22 INFO - SUITE-START | Running 2 tests 03:55:22 INFO - TEST-START | dromaeo_css 03:55:22 INFO - operating with platform_type : linux_ 03:55:22 INFO - Initialising browser for dromaeo_css test... 03:55:22 INFO - TEST-INFO | started process 8601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5azyIm/profile http://localhost:58695/getInfo.html) 03:55:26 INFO - PROCESS | 8601 | __metrics Screen width/height:1600/1200 03:55:26 INFO - PROCESS | 8601 | colorDepth:24 03:55:26 INFO - PROCESS | 8601 | Browser inner width/height: 1024/697 03:55:26 INFO - PROCESS | 8601 | __metrics 03:55:27 ERROR - PROCESS | 8601 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:55:28 INFO - TEST-INFO | 8601: exit 0 03:55:28 INFO - Browser initialized. 03:55:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:55:28 INFO - TEST-INFO | started process 8681 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5azyIm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:40 INFO - PROCESS | 8681 | RSS: Main: 154722304 03:55:40 INFO - PROCESS | 8681 | 03:56:32 INFO - PROCESS | 8681 | 1464087392096 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] 03:58:43 INFO - PROCESS | 8681 | Cycle 1(1): loaded http://localhost:58695/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58695/tests/dromaeo/cssquery-ext.html) 03:58:44 INFO - PROCESS | 8681 | RSS: Main: 236593152 03:58:44 INFO - PROCESS | 8681 | 04:01:47 INFO - PROCESS | 8681 | Cycle 1(1): loaded http://localhost:58695/tests/dromaeo/cssquery-ext.html (next: http://localhost:58695/tests/dromaeo/cssquery-jquery.html) 04:01:47 INFO - PROCESS | 8681 | RSS: Main: 240390144 04:01:47 INFO - PROCESS | 8681 | 04:04:49 INFO - PROCESS | 8681 | Cycle 1(1): loaded http://localhost:58695/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58695/tests/dromaeo/cssquery-mootools.html) 04:04:50 INFO - PROCESS | 8681 | RSS: Main: 234409984 04:04:50 INFO - PROCESS | 8681 | 04:07:52 INFO - PROCESS | 8681 | Cycle 1(1): loaded http://localhost:58695/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58695/tests/dromaeo/cssquery-prototype.html) 04:07:53 INFO - PROCESS | 8681 | RSS: Main: 236802048 04:07:53 INFO - PROCESS | 8681 | 04:10:56 INFO - PROCESS | 8681 | Cycle 1(1): loaded http://localhost:58695/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58695/tests/dromaeo/cssquery-yui.html) 04:10:56 INFO - PROCESS | 8681 | RSS: Main: 215220224 04:10:56 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | Cycle 1(1): loaded http://localhost:58695/tests/dromaeo/cssquery-yui.html (next: http://localhost:58695/tests/dromaeo/cssquery-dojo.html) 04:13:59 INFO - PROCESS | 8681 | RSS: Main: 279670784 04:13:59 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | __start_tp_report 04:13:59 INFO - PROCESS | 8681 | _x_x_mozilla_page_load 04:13:59 INFO - PROCESS | 8681 | _x_x_mozilla_page_load_details 04:13:59 INFO - PROCESS | 8681 | |i|pagename|runs| 04:13:59 INFO - PROCESS | 8681 | |0;dojo.html;2674.7325267473248;2683.838969661819;2693.1381957773515;2711.5661494160936;2721.5101281769284;4642.651801114913;4676.228422310319;4713.128071306811;4754.738489383087;4830.806767729291;4682.859514214579;4703.200455922492;4706.176419126657;4755.3104799804005;4771.403574553181;4116.711830171889;4274.145170965804;4351.5648435156545;4385.364122202279;4478.23869942109;4388.144311859189;4420.690551661369;4426.933595996063;4436.134953684033;4469.329600559926;4223.02870339822;4267.722598031118;4358.215521206182;4379.75911324877;4396.604305612478;4328.978355108205;4333.674974376934;4339.175556644227;4384.320430333303;4397.824087036514;4355.542668019844;4362.36745671879;4366.061296821199;4386.0569977455;4413.514513403523;4577.473590537097;4621.075784843045;4650.0932318197965;4678.859634210945;4695.577398034194;5124.666896651705;5181.611379146579;5188.351456067991;5189.610779191538;5191.351081114861;5212.9739351303;5222.060029194743;5225.817096401645;5232.555232805216;5236.633435659505;4680.9297860532115;4684.320773487825;4747.216709242936;4753.524647535219;4813.9037219256115;5184.455632158644;5208.583313334924;5212.374515058217;5213.348331458567;5218.2955301034635;4851.80592776285;4950.752462376867;4993.975030124826;4997.400311962515;4998.450170481244;5058.696478211319;5099.5410413063;5102.107131252016;5106.285120083191;5129.333186685707;5070.492950704974;5109.693418394908;5116.692998420107;5119.257707632372;5163.612729045337;4863.537963893425;4985.725785081855;5091.389033316026;5100.872478188075;5109.054824857339;4211.326187809936;4248.702590818675;4250.489941207075;4269.530351661315;4283.914321713548;3720.9813950930616;3748.2316125194816;3752.6434988676033;3779.3952967525065;3784.791836449022;4306.0526684129445;4338.891527711769;4357.607815296638;4403.361512580658;4410.911781764411;5066.746662666852;5103.923441148386;5108.157154069611;5108.846734597893;5168.173092305288;4382.978085109554;4408.845690400884;4414.646828253796;4455.643548516111;4459.264221403497;4446.288593824973;4528.6150677192145;4546.659000574904;4550.271956486946;4558.111168322145;4863.221884498605;4867.099586576494;4870;4922.50774922512;4924.285978533164;5143.125668636416;5143.794248230029;5152;5152.896942061213;5159.974200128975;4747.216709243075;4751.619870410428;4813.975930120467;4829.927551086666;4864.586510146677;5021.372328458942;5026.170681837456;5036.697798132123;5037.471065538066;5081.517255860687;5091.6181286402925;5096.796128154981;5099.056674515226;5104.821331253388;5107.565856902205;4814.494478079751;4887.853364399074;4932.087563800708;4939.382577177853;4966.528179822911;4904.190808516555;4936.407631084293;4942.925856112233;4950.306957025947;4983.576396006235;4799.568038876518;4879.585235255043;4886.877828054327;4890.853274401774;4934.087193869145;4965.379327584052;4997.575206107522;5005.224190250517;5006.724630145377;5012.523810238022;4897.094037603055;4901.558859702502;4902.117618828645;4927.482614325588;4957.925631115609 04:13:59 INFO - PROCESS | 8681 | |1;ext.html;580.7589850212162;593.1014513012789;593.2613895699855;596.8179705189918;610.7740136149624;40607.39088913669;42194.36708449372;42270.99999999996;46147.53852461474;46148.769256153755;40121.99695007626;40483.59516404835;40494.392584111185;40607.79696101523;40648.39027414591;7794.3764498839955;7935.285824275814;7943.443958922878;7952.045754509438;7955.920440795576;7867.645955931968;7939.325157361631;7944.483608565453;7959.562224077674;7960.442769006172;7958.4031197660115;8002.559859207741;8017.599120044004;8027;8031.759047228593;7901.288884000439;7963.681452741884;7978.2420670036545;7978.242067003684;7981.561014144219;7865.488743231672;7948.165442628499;7957.761267161936;7967.601619918981;7969.083555391147;39722.801385993174;39966;40036.19927601461;40078.19843603141;40109.78572785548;3288.391647545212;3290.7696461247724;3762.435634654796;3773.151041015777;3868.2650296443867;28470.145895623165;28968.710312896812;31200.37599248002;31320;32652.510212346835;3465.5668041494814;3578.320119177374;3592.209713862946;3708.369577171887;3752.5309336332957;261283;266853;267895;268220;268268;49790;51366.48633513692;59196.40803591909;60632.393676063555;60861.69569152126;62289.377106229265;63017.68491157606;63486.6825665878;69508.6524567384;69690.65154674296;12601.369931503388;12645.74708505843;12737.235765854079;12743.553975610808;12744.553940612219;7935.761927142195;8974.237189838937;9009.549522523848;9054.139856713602;9108.362414630912;18941;19623.769356416204;19699.803001969798;19770.60458790816;19782.40652780419;7363.410927125924;7379.7048118075745;7473.663685134182;7631.732889348847;7732.922670773332;804.6982381606897;886.9246114080375;900.1763386501278;949.1979277510493;965.1892410375178;28605.57091643627;28717.856410718232;29027.709722902502;29379.265518361786;29406.67669954857;983.5573991703762;985.0789511806483;987.896270891546;1030.9742256443649;1037.5953378182514;14999.325030373659;15329;15494.457693980656;15706;15838.12890291022;366848;370471;371755;372491;372530;50693.95836249837;51097.233541496906;51141.48858511441;51297.743511282206;51355.74322128366;1115.6262652011667;1190.547591915084;1199.2984104298735;1228.5331574001823;1249.3940438887132;28402.715972840833;29761.5535766968;29762.702372975993;29820.552691709207;30294.394112118076;42892;43320;43944.78027609969;43967;43967.340489892034;244055;244429;244792;245104;245430;32910.670893290764;37725.62274377331;38829.2234155321;38835.417468737425;41516.37725434061;42588.78705606576;42880.14239715251;43002.35496467618;43573.56426435822;43682.34476482919;36500;36949.445758314185;37118;37548.62451375451;38058.809705951295;36564.81717591395;36632.26735465329;36656.45015324719;36951.076223094635;37296;35544.46683299804;36470.452943205346;36512.63487365199;36690.44964325591;36742.44886326654;31385.686143139188;32727.34545309033;33219.50170747392;33444.83277583597;33517.497237541946;25261.621075683513;25632.359191020372;25649;25816.096436624626;25871.48257034811 04:13:59 INFO - PROCESS | 8681 | |2;jquery.html;357.6137771207096;363.8290003698261;366.3735013127551;368.9797061161635;382.69193299393993;15674.608134796636;16453.753193702105;16844;16853.662926741472;17166;14773.261336933165;15547;15654.608634784136;15744.055356678578;15768.211589420513;5059.721715305656;5276.709780962045;5284.920726189111;5285.207218917155;5286.2070689396705;3748.2128752961776;3929;5132.4610915853855;5705.315362156547;6045.093236014611;6061.45446909778;6075.574709770318;6086.726097325631;6103.938960610381;6107.816765497042;5921.171036054956;6004.969975150118;6062.514998800086;6114.602550834204;6119.66341851198;3427.7943323400427;5024.321716568253;5262.184361423985;5341.599380046512;5349.090654588729;19649.312274070482;20178.19287228509;20201.494962625904;20549.4862628434;20586;1898.2786541114426;2002.9699554506694;2008.2870580943847;2098.1187901081585;2513.8743062846784;12747.872521274761;12776.488940442372;12959.740805183937;13038.739225215537;13219.669508262274;1697.8896371735798;1749.3702267183803;1776.4936992956946;1782.322717367405;1799.7210432383001;67173.3282667172;67471;70516.29483705148;70910;71211.64394178048;10153.949230253802;10183.949080254552;10188.337758045851;10205.489725513695;10408.167346612252;14322.212278324583;14365.7845132321;14374.640633984234;14403.063800852911;14422.711545769025;6681.265060843303;6688.331166883273;6752.662366881735;6818.590884546943;6871.694378068151;6177.505799536027;6205.193324867829;6306.432421082125;6327.620342779356;6329.177206963065;4369.497507786582;4480.596746292849;4512.390827238347;4538.863834084983;4581.266997280419;1491.9104853708811;1587.547548948544;1599.3122957128546;1672.9163541823104;1706.9487915362558;847.588919374103;866.6490071521044;868.7610907000499;909.8680691299725;914.2274777812737;16435.67128657444;16689.582760431087;16779.83220167807;17119.91440042792;17125.743113853303;891.5586784541694;903.1645727701849;904.6833608237196;910.7677542226822;939.0890835889177;8087.474314169678;9583.137517623447;9604.471754053595;9620.278479113955;9710.611575537041;387970;393255;395298;411647;411829;73157.26842731611;73838.63080684563;74810.25189748032;75705;76782;880.8898887639045;886.8980067292345;897.8473659477904;899.1862364560084;904.69692652962;15043.097414155185;15511.84488155104;15980.840191597936;16105.114218718083;16136.838631613533;34173.825616930386;34174;35424.46863297001;35427.291454170256;35769.82115089408;48119.5188048115;48155.75922120507;50448.24327635162;50584.494155057975;51344;7216.603086830065;7357.742479013209;7376.557406555624;7470.252974702486;7561.735339263099;7885.250901164381;9845.556949937414;10574.524146413583;11186.440677966231;11220.99011089006;9020.639174432948;9094.090590940854;9461.763455913657;9546.331756776959;9632.373895696757;9376.29677774156;9379.062093790566;9394.906050939404;9575.138237558374;9701.272404569545;9397;9482.573284202366;9670.323077384515;9958.203343732628;10079.294449388472;6346.111544383883;7071.151461824614;7091.893621595577;7279.365679437427;7471.551706897603;8119.188081191834;9578.9042109578;9661.758456038655;9889.604415823575;10231.28381013322 04:13:59 INFO - PROCESS | 8681 | |3;mootools.html;1272.0396100943797;1355.7559639264935;1410.7108042851214;1462.7659574468087;1700;6290.748370065197;7139.500234983553;7349.228331025246;7380.298871607195;7535.660895259713;7339.449541284398;7408.777736667895;7465.738699145531;7473.4394920381055;7479.439042071853;2125.3092744857945;2151.9892400537974;2154.881481518516;2154.9461263468384;2155.2348916134783;2100.338393406072;2124.4370241885913;2181.301983365324;2181.5418762059985;2183.1376606240524;2118.1315660579166;2131.5949969505746;2144.8176904963098;2146.957060858782;2147.8281737461043;2118.9682154767693;2119.745630524339;2124.022949443258;2126.415235810157;2127.0322003488377;2036.745406824147;2101.2120454829437;2105.3473423238843;2108.262108262096;2109.715188449555;7363.263673632648;7387.298206670358;7394.223606521292;7396.630168491554;7600.239976002355;4153.273177193979;4208.032152604918;4241.957580424187;4251.87244382669;4256.2338779019765;2837.957430638542;2855.457463082008;2877.007432435806;2908.1420980810713;2909.8254104753782;901.9819603607957;910.6812615584493;911.7173676160412;915.272358475014;916.9266458683289;10128.240381971382;10237.078662920298;10279;10297.433641149733;10300.690979270634;3838.5201849768778;3939.901502462404;4002.9799851000557;4006.759594424344;4071.8371265149062;8131.552764598004;8141.9185808141165;8169.2647661710735;8188.7952801180445;8190.549519776469;4171.311733563928;4180.393842892763;4182.895427614334;4184.225918205142;4187.602177793105;3320.8007519548905;3653.7990410527145;3782.319182547113;3841.9231615368094;3909.0618251619976;3248.853801578887;3252.5609042778924;3318.1870441741926;3340.816255105944;3428.6914177724125;964.7732782796037;978.4031740638205;979.1041197304387;1012.4937531234383;1018.8777346718441;678.864227154571;786.2216405758259;808.9676412943417;811.2860682599393;833.8582440985047;4861.489543597942;4938.08645400602;5018.272350509155;5045.571126454219;5108.7190204538365;390.10081761539357;397.16595150184384;399.1279055264257;400.23355274649305;405.49313358302123;3387.136280248521;3435.9484607730906;3444.8794292200155;3460.100373902753;3520.0495866116007;8857.424267422597;9262.027487113755;9369.437833729999;9369.765755856159;9385.38994965325;9211.124943130391;9231.446113233227;9239.168474837297;9244.16802487766;9244.260459163252;6835.58986460814;6877.724891004304;6888.070110535114;6903.309669033157;6904.585724856524;4862.367892173995;4961.107000739901;5014.297998280316;5066.594672426123;5071.492850714899;8599.53807852654;8608.48349099056;8609.956950215208;8672.696455624024;8700.347473939353;7769.844603108019;7978.481398709066;8014.318782903285;8254.174582541698;8778.122187781171;5769.538436924952;6151.538634602333;6264.843378915381;6349.14286571307;6362.554621176473;6979.511434199558;7235.963820180866;7242.456815738736;7244.022057022235;7244.673989670583;6486.027520415666;6677.833054173684;6685.498587606046;6724.529282950147;6735.191776986793;6519.445847103049;6553.672316384066;6624.403803657694;6657.800265992028;6709.060731497497;5985.940140598713;6021.729022193924;6043.2748070231855;6045.365236650088;6046.697665116639;4392.275274579786;4405.911881762411;4433.623142032834;4523.348977623078;4534.659900507541;4357.694961352801;4417.757023363617;4481.103779244229;4510.977445112753;4548.0221752323405 04:13:59 INFO - PROCESS | 8681 | |4;prototype.html;279.70910253336524;279.94401119776046;284.8063316944478;288.052307906986;288.6103759924101;4800.9759951200285;4802.223177424354;4805.663603547749;4818.855434336967;4853.840041181676;4770.809167633299;4784.784684689189;4789.281607758838;4789.66472346935;4802.207635740107;3564.8770637249313;3667.743257971943;3669.5229620149344;3772.77363358198;3793.6965042796646;3741.7380783345175;3749.400095984643;3761.8683346082894;3781.508403907502;3791.393377059671;3536.133647256426;3740.3828368319196;3745.2322273933914;3753.643403876641;3757.4739536464917;3652.7443078984484;3728.8881333560034;3734.439834024891;3738.8504459821847;3753.0429740416293;3310.6027276726704;3312.5528053712683;3315.270640459095;3322.5680661513848;3324.1523411530147;4474.597286244254;4476.574725401114;4500.457241658485;4521.033350492547;4540.772961351952;3995.6215105788456;4205.476713971592;4226.562968590663;4238.131183107455;4243.893902652428;4950.7029578225065;4958.8760280993265;4963.131451995886;4983.252512123175;4984.451710311862;3389.9660603515918;3532.6467353264725;3535.5757309122814;3550.5384300041087;3566.28674265148;5112.079825631385;5128.358955130609;5136.64043516954;5143.537081662631;5152.072626927152;3560.1989552351033;3567.714582833367;3579.3736096183065;3583.104223944014;3589.3000864831106;3637.7999210043704;3646.781193128421;3649.525561676965;3656.7623104498653;3666.5233519642275;3923.6861051115843;4188.4136220929095;4196.370544418301;4196.832126714959;4208.095259519218;4952.158133117378;4962.131626965339;4973.45292017885;4979;4990.579568909076;1244.993775031119;1258.3205069262679;1265.0322503284995;1268.9873101269054;1269.3906924676207;787.9172686867911;822.7284995951321;893.5308962794585;906.5059542549326;923.6720964057797;4336.371226172188;4395.758233297135;4398.64810815134;4400.537943515948;4405.207062728676;5000.649954503223;5028.321176641107;5049.267856160836;5066.797328106834;5069.746512674352;4216.768077755692;4350.891227719332;4365.3670217818235;4373.825046998085;4397.790607582876;2655.5618322976493;2679.767307038745;2682.2757855379327;2693.6363590915366;2695.9056433025144;4801.591864691471;4809.302651115569;4814.737073575414;4821.807127714922;4832.347633069561;4938.555530002317;5138;5145.845624631267;5146.614003949719;5238.5547228486;4847.660663753574;4859.125357435625;4866.148424025781;4868.829590964299;4883.487233840538;5128.461511541234;5135.229715542699;5137.743112844418;5146.8970620588125;5163.3545806774155;4794.352762377034;4998.5754060092695;5006.224035274538;5023;5031.773570189277;4807.302941073594;4864.829730959399;4866.245731911559;4867.515407800654;4896.706197628154;3572.2319701264355;3597.586277578112;3659.645931005545;3666.908327291839;3677.558692956862;4994.925076123934;5152.201408781645;5195.766190521511;5199.610029247746;5205.219217117311;4988.9251661225835;5005;5006.374203224597;5010.549050585319;5020.297158397754;4996.725180115129;5006.148954677787;5015.523525265094;5021.698698078127;5026.396832380138;4648.395708557866;4867.659263851497;4915.508449155056;4951.628627852853;4973.825916092919;4774.331593576832;4876.731779752147;4982.775775090057;4995.925061124013;5029.346184995927;4882.658213924991;4890;4899.975500122477;4902.852914412573;4937.728424936663 04:13:59 INFO - PROCESS | 8681 | |5;yui.html;593.4186289640065;641.0960545630659;697.0728930522406;700.4221517248271;740.7148247924547;10614.150867930566;11739.589114380988;12510.562130325452;12513.812292815604;12827.294498802563;11959.103067269945;12459.878610925014;12596.559120430788;12716.364181790897;12722.554710585131;802.7391097893194;815.8409110223508;816.808050108224;817.1134319263606;817.8977627796526;625.7184267079809;773.9226077392273;816.2123550773503;816.7590560784582;817.0971076959963;851.9275861551776;852.5353682243161;854.3848429131016;854.5983387807752;854.8931383577053;841.5707988925631;847.5931552854634;848.0501837941483;849.6176720475748;849.8257857139303;623.5541587764725;624.3818619566641;624.5784095735361;624.753222477119;624.8250489862845;11452.427378631035;11462.598809041727;11478.94260528692;11480.196386252966;11494.827577586342;12089.879101208964;12360.320182389965;12553.121281510297;12602.873971260262;12645.873541264562;9844.276387053207;9962.203023758155;10168.847467287997;10344.22418318629;10419.479026048668;3244.9675503244903;3277.3936821687826;3320.7841490303294;3352.3127758809387;3375.1730825947557;45723.31415028777;45945.770271148765;46032.309515357294;46103.76948115272;46395;9795.07398024185;9916.25628077897;9974.650887218913;9999.300048996645;10022.398656080659;17652.558686032953;17655.38206162804;17699.38052168194;17718.379856704953;17742.467725968243;6370.076338930921;6539.313372095957;6587.80236592903;6629.436497897636;6669.1330127083165;3670.4310831820576;3689.7048236141045;3708.42519409492;3713.164537978933;3735.495708079429;2605.557055300603;2696.32591852037;2706.796990225741;2707;2709.5122877881777;477.31266975555087;479.90641824843823;495.0495049504887;498.5961371289267;552.2296396526823;477.5773440505109;492.8496808473378;545.3237984898776;569.2542768972659;571.1062187676356;8308.70919517826;8474.5339006354;8495.447795893248;8645;8711.60797764102;606.5087279303779;620.5749061892618;623.9313675495691;635.2789583822395;647.6243778608396;4003.979980100081;4284.592963668447;4290.120525292307;4341.82632694695;4406.735595864258;56409.435905641236;57103;57429.712851436314;57453;57918.4208157913;55218.72390638021;55905.720471397384;55951.720241398536;55969.440305597236;56174.7191264041;49726.502734972186;50033.499665002884;50274.74862625664;50618.999999999265;50663;8373.49759014461;8420.073791883011;8478.703245386629;8524.062353141026;8612.397132200686;32481;33056.83471582627;33750.83124584361;33940.66059339375;33987.3202535943;30944.69055309418;39504.60495395009;43518;45458;46037.76981115207;10454.58181672755;10583.4708264588;10984.725381865517;11075.501602428072;11076.280041797258;11861.76276474483;11994.400279986141;12351.38243087824;12359.567415140427;12826.23042617446;11108.277961932448;11346.432678365883;11655.59205427806;11686.065114790967;11769.588064417705;11403.942980285046;11414.258073225214;11525.193236473366;11671.708207294885;12344.753104937672;10746.946265268623;10802.081823044815;11277.887221127683;11764.647060588197;11794.174407791372;9507;9733.318667693193;9994.60021599157;10014.949925250326;10039.247056470647;9735.22118230554;9814.116729494379;9923.751906202402;9929.254311609187;10037.498125093862 04:13:59 INFO - PROCESS | 8681 | __end_tp_report 04:13:59 INFO - PROCESS | 8681 | __start_cc_report 04:13:59 INFO - PROCESS | 8681 | _x_x_mozilla_cycle_collect,902 04:13:59 INFO - PROCESS | 8681 | __end_cc_report 04:13:59 INFO - PROCESS | 8681 | __startTimestamp1464088439714__endTimestamp 04:13:59 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | ------- Summary: start ------- 04:13:59 INFO - PROCESS | 8681 | Number of tests: 6 04:13:59 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | [#0] dojo.html Cycles:165 Average:4703.22 Median:4863.22 stddev:499.99 (10.3%) stddev-sans-first:475.52 04:13:59 INFO - PROCESS | 8681 | Values: 2674.7 2683.8 2693.1 2711.6 2721.5 4642.7 4676.2 4713.1 4754.7 4830.8 4682.9 4703.2 4706.2 4755.3 4771.4 4116.7 4274.1 4351.6 4385.4 4478.2 4388.1 4420.7 4426.9 4436.1 4469.3 4223.0 4267.7 4358.2 4379.8 4396.6 4329.0 4333.7 4339.2 4384.3 4397.8 4355.5 4362.4 4366.1 4386.1 4413.5 4577.5 4621.1 4650.1 4678.9 4695.6 5124.7 5181.6 5188.4 5189.6 5191.4 5213.0 5222.1 5225.8 5232.6 5236.6 4680.9 4684.3 4747.2 4753.5 4813.9 5184.5 5208.6 5212.4 5213.3 5218.3 4851.8 4950.8 4994.0 4997.4 4998.5 5058.7 5099.5 5102.1 5106.3 5129.3 5070.5 5109.7 5116.7 5119.3 5163.6 4863.5 4985.7 5091.4 5100.9 5109.1 4211.3 4248.7 4250.5 4269.5 4283.9 3721.0 3748.2 3752.6 3779.4 3784.8 4306.1 4338.9 4357.6 4403.4 4410.9 5066.7 5103.9 5108.2 5108.8 5168.2 4383.0 4408.8 4414.6 4455.6 4459.3 4446.3 4528.6 4546.7 4550.3 4558.1 4863.2 4867.1 4870.0 4922.5 4924.3 5143.1 5143.8 5152.0 5152.9 5160.0 4747.2 4751.6 4814.0 4829.9 4864.6 5021.4 5026.2 5036.7 5037.5 5081.5 5091.6 5096.8 5099.1 5104.8 5107.6 4814.5 4887.9 4932.1 4939.4 4966.5 4904.2 4936.4 4942.9 4950.3 4983.6 4799.6 4879.6 4886.9 4890.9 4934.1 4965.4 4997.6 5005.2 5006.7 5012.5 4897.1 4901.6 4902.1 4927.5 4957.9 04:13:59 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | [#1] ext.html Cycles:180 Average:46574.26 Median:39279.11 stddev:78490.84 (199.8%) stddev-sans-first:78635.06 04:13:59 INFO - PROCESS | 8681 | Values: 580.8 593.1 593.3 596.8 610.8 40607.4 42194.4 42271.0 46147.5 46148.8 40122.0 40483.6 40494.4 40607.8 40648.4 7794.4 7935.3 7943.4 7952.0 7955.9 7867.6 7939.3 7944.5 7959.6 7960.4 7958.4 8002.6 8017.6 8027.0 8031.8 7901.3 7963.7 7978.2 7978.2 7981.6 7865.5 7948.2 7957.8 7967.6 7969.1 39722.8 39966.0 40036.2 40078.2 40109.8 3288.4 3290.8 3762.4 3773.2 3868.3 28470.1 28968.7 31200.4 31320.0 32652.5 3465.6 3578.3 3592.2 3708.4 3752.5 261283.0 266853.0 267895.0 268220.0 268268.0 49790.0 51366.5 59196.4 60632.4 60861.7 62289.4 63017.7 63486.7 69508.7 69690.7 12601.4 12645.7 12737.2 12743.6 12744.6 7935.8 8974.2 9009.5 9054.1 9108.4 18941.0 19623.8 19699.8 19770.6 19782.4 7363.4 7379.7 7473.7 7631.7 7732.9 804.7 886.9 900.2 949.2 965.2 28605.6 28717.9 29027.7 29379.3 29406.7 983.6 985.1 987.9 1031.0 1037.6 14999.3 15329.0 15494.5 15706.0 15838.1 366848.0 370471.0 371755.0 372491.0 372530.0 50694.0 51097.2 51141.5 51297.7 51355.7 1115.6 1190.5 1199.3 1228.5 1249.4 28402.7 29761.6 29762.7 29820.6 30294.4 42892.0 43320.0 43944.8 43967.0 43967.3 244055.0 244429.0 244792.0 245104.0 245430.0 32910.7 37725.6 38829.2 38835.4 41516.4 42588.8 42880.1 43002.4 43573.6 43682.3 36500.0 36949.4 37118.0 37548.6 38058.8 36564.8 36632.3 36656.5 36951.1 37296.0 35544.5 36470.5 36512.6 36690.4 36742.4 31385.7 32727.3 33219.5 33444.8 33517.5 25261.6 25632.4 25649.0 25816.1 25871.5 04:13:59 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | [#2] jquery.html Cycles:180 Average:24352.55 Median:28303.09 stddev:65957.52 (233.0%) stddev-sans-first:66117.94 04:13:59 INFO - PROCESS | 8681 | Values: 357.6 363.8 366.4 369.0 382.7 15674.6 16453.8 16844.0 16853.7 17166.0 14773.3 15547.0 15654.6 15744.1 15768.2 5059.7 5276.7 5284.9 5285.2 5286.2 3748.2 3929.0 5132.5 5705.3 6045.1 6061.5 6075.6 6086.7 6103.9 6107.8 5921.2 6005.0 6062.5 6114.6 6119.7 3427.8 5024.3 5262.2 5341.6 5349.1 19649.3 20178.2 20201.5 20549.5 20586.0 1898.3 2003.0 2008.3 2098.1 2513.9 12747.9 12776.5 12959.7 13038.7 13219.7 1697.9 1749.4 1776.5 1782.3 1799.7 67173.3 67471.0 70516.3 70910.0 71211.6 10153.9 10183.9 10188.3 10205.5 10408.2 14322.2 14365.8 14374.6 14403.1 14422.7 6681.3 6688.3 6752.7 6818.6 6871.7 6177.5 6205.2 6306.4 6327.6 6329.2 4369.5 4480.6 4512.4 4538.9 4581.3 1491.9 1587.5 1599.3 1672.9 1706.9 847.6 866.6 868.8 909.9 914.2 16435.7 16689.6 16779.8 17119.9 17125.7 891.6 903.2 904.7 910.8 939.1 8087.5 9583.1 9604.5 9620.3 9710.6 387970.0 393255.0 395298.0 411647.0 411829.0 73157.3 73838.6 74810.3 75705.0 76782.0 880.9 886.9 897.8 899.2 904.7 15043.1 15511.8 15980.8 16105.1 16136.8 34173.8 34174.0 35424.5 35427.3 35769.8 48119.5 48155.8 50448.2 50584.5 51344.0 7216.6 7357.7 7376.6 7470.3 7561.7 7885.3 9845.6 10574.5 11186.4 11221.0 9020.6 9094.1 9461.8 9546.3 9632.4 9376.3 9379.1 9394.9 9575.1 9701.3 9397.0 9482.6 9670.3 9958.2 10079.3 6346.1 7071.2 7091.9 7279.4 7471.6 8119.2 9578.9 9661.8 9889.6 10231.3 04:13:59 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | [#3] mootools.html Cycles:180 Average:4862.81 Median:4987.70 stddev:2741.54 (55.0%) stddev-sans-first:2735.95 04:13:59 INFO - PROCESS | 8681 | Values: 1272.0 1355.8 1410.7 1462.8 1700.0 6290.7 7139.5 7349.2 7380.3 7535.7 7339.4 7408.8 7465.7 7473.4 7479.4 2125.3 2152.0 2154.9 2154.9 2155.2 2100.3 2124.4 2181.3 2181.5 2183.1 2118.1 2131.6 2144.8 2147.0 2147.8 2119.0 2119.7 2124.0 2126.4 2127.0 2036.7 2101.2 2105.3 2108.3 2109.7 7363.3 7387.3 7394.2 7396.6 7600.2 4153.3 4208.0 4242.0 4251.9 4256.2 2838.0 2855.5 2877.0 2908.1 2909.8 902.0 910.7 911.7 915.3 916.9 10128.2 10237.1 10279.0 10297.4 10300.7 3838.5 3939.9 4003.0 4006.8 4071.8 8131.6 8141.9 8169.3 8188.8 8190.5 4171.3 4180.4 4182.9 4184.2 4187.6 3320.8 3653.8 3782.3 3841.9 3909.1 3248.9 3252.6 3318.2 3340.8 3428.7 964.8 978.4 979.1 1012.5 1018.9 678.9 786.2 809.0 811.3 833.9 4861.5 4938.1 5018.3 5045.6 5108.7 390.1 397.2 399.1 400.2 405.5 3387.1 3435.9 3444.9 3460.1 3520.0 8857.4 9262.0 9369.4 9369.8 9385.4 9211.1 9231.4 9239.2 9244.2 9244.3 6835.6 6877.7 6888.1 6903.3 6904.6 4862.4 4961.1 5014.3 5066.6 5071.5 8599.5 8608.5 8610.0 8672.7 8700.3 7769.8 7978.5 8014.3 8254.2 8778.1 5769.5 6151.5 6264.8 6349.1 6362.6 6979.5 7236.0 7242.5 7244.0 7244.7 6486.0 6677.8 6685.5 6724.5 6735.2 6519.4 6553.7 6624.4 6657.8 6709.1 5985.9 6021.7 6043.3 6045.4 6046.7 4392.3 4405.9 4433.6 4523.3 4534.7 4357.7 4417.8 4481.1 4511.0 4548.0 04:13:59 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | [#4] prototype.html Cycles:180 Average:4127.85 Median:4792.01 stddev:1198.25 (25.0%) stddev-sans-first:1166.28 04:13:59 INFO - PROCESS | 8681 | Values: 279.7 279.9 284.8 288.1 288.6 4801.0 4802.2 4805.7 4818.9 4853.8 4770.8 4784.8 4789.3 4789.7 4802.2 3564.9 3667.7 3669.5 3772.8 3793.7 3741.7 3749.4 3761.9 3781.5 3791.4 3536.1 3740.4 3745.2 3753.6 3757.5 3652.7 3728.9 3734.4 3738.9 3753.0 3310.6 3312.6 3315.3 3322.6 3324.2 4474.6 4476.6 4500.5 4521.0 4540.8 3995.6 4205.5 4226.6 4238.1 4243.9 4950.7 4958.9 4963.1 4983.3 4984.5 3390.0 3532.6 3535.6 3550.5 3566.3 5112.1 5128.4 5136.6 5143.5 5152.1 3560.2 3567.7 3579.4 3583.1 3589.3 3637.8 3646.8 3649.5 3656.8 3666.5 3923.7 4188.4 4196.4 4196.8 4208.1 4952.2 4962.1 4973.5 4979.0 4990.6 1245.0 1258.3 1265.0 1269.0 1269.4 787.9 822.7 893.5 906.5 923.7 4336.4 4395.8 4398.6 4400.5 4405.2 5000.6 5028.3 5049.3 5066.8 5069.7 4216.8 4350.9 4365.4 4373.8 4397.8 2655.6 2679.8 2682.3 2693.6 2695.9 4801.6 4809.3 4814.7 4821.8 4832.3 4938.6 5138.0 5145.8 5146.6 5238.6 4847.7 4859.1 4866.1 4868.8 4883.5 5128.5 5135.2 5137.7 5146.9 5163.4 4794.4 4998.6 5006.2 5023.0 5031.8 4807.3 4864.8 4866.2 4867.5 4896.7 3572.2 3597.6 3659.6 3666.9 3677.6 4994.9 5152.2 5195.8 5199.6 5205.2 4988.9 5005.0 5006.4 5010.5 5020.3 4996.7 5006.1 5015.5 5021.7 5026.4 4648.4 4867.7 4915.5 4951.6 4973.8 4774.3 4876.7 4982.8 4995.9 5029.3 4882.7 4890.0 4900.0 4902.9 4937.7 04:13:59 INFO - PROCESS | 8681 | 04:13:59 INFO - PROCESS | 8681 | [#5] yui.html Cycles:180 Average:13646.82 Median:46249.38 stddev:16189.75 (35.0%) stddev-sans-first:16205.49 04:13:59 INFO - PROCESS | 8681 | Values: 593.4 641.1 697.1 700.4 740.7 10614.2 11739.6 12510.6 12513.8 12827.3 11959.1 12459.9 12596.6 12716.4 12722.6 802.7 815.8 816.8 817.1 817.9 625.7 773.9 816.2 816.8 817.1 851.9 852.5 854.4 854.6 854.9 841.6 847.6 848.1 849.6 849.8 623.6 624.4 624.6 624.8 624.8 11452.4 11462.6 11478.9 11480.2 11494.8 12089.9 12360.3 12553.1 12602.9 12645.9 9844.3 9962.2 10168.8 10344.2 10419.5 3245.0 3277.4 3320.8 3352.3 3375.2 45723.3 45945.8 46032.3 46103.8 46395.0 9795.1 9916.3 9974.7 9999.3 10022.4 17652.6 17655.4 17699.4 17718.4 17742.5 6370.1 6539.3 6587.8 6629.4 6669.1 3670.4 3689.7 3708.4 3713.2 3735.5 2605.6 2696.3 2706.8 2707.0 2709.5 477.3 479.9 495.0 498.6 552.2 477.6 492.8 545.3 569.3 571.1 8308.7 8474.5 8495.4 8645.0 8711.6 606.5 620.6 623.9 635.3 647.6 4004.0 4284.6 4290.1 4341.8 4406.7 56409.4 57103.0 57429.7 57453.0 57918.4 55218.7 55905.7 55951.7 55969.4 56174.7 49726.5 50033.5 50274.7 50619.0 50663.0 8373.5 8420.1 8478.7 8524.1 8612.4 32481.0 33056.8 33750.8 33940.7 33987.3 30944.7 39504.6 43518.0 45458.0 46037.8 10454.6 10583.5 10984.7 11075.5 11076.3 11861.8 11994.4 12351.4 12359.6 12826.2 11108.3 11346.4 11655.6 11686.1 11769.6 11403.9 11414.3 11525.2 11671.7 12344.8 10746.9 10802.1 11277.9 11764.6 11794.2 9507.0 9733.3 9994.6 10014.9 10039.2 9735.2 9814.1 9923.8 9929.3 10037.5 04:13:59 INFO - PROCESS | 8681 | -------- Summary: end -------- 04:13:59 INFO - PROCESS | 8681 | 04:14:00 INFO - TEST-INFO | 8681: exit 0 04:14:00 INFO - TEST-OK | dromaeo_css | took 1118411ms 04:14:00 INFO - TEST-START | kraken 04:14:00 INFO - operating with platform_type : linux_ 04:14:00 INFO - Initialising browser for kraken test... 04:14:00 INFO - TEST-INFO | started process 8857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNWPiu0/profile http://localhost:58695/getInfo.html) 04:14:04 INFO - PROCESS | 8857 | __metrics Screen width/height:1600/1200 04:14:04 INFO - PROCESS | 8857 | colorDepth:24 04:14:04 INFO - PROCESS | 8857 | Browser inner width/height: 1024/697 04:14:04 INFO - PROCESS | 8857 | __metrics 04:14:05 ERROR - PROCESS | 8857 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:14:06 INFO - TEST-INFO | 8857: exit 0 04:14:06 INFO - Browser initialized. 04:14:06 INFO - Running cycle 1/1 for kraken test... 04:14:06 INFO - TEST-INFO | started process 8937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNWPiu0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:18 INFO - PROCESS | 8937 | RSS: Main: 155062272 04:14:18 INFO - PROCESS | 8937 | 04:14:21 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58695/tests/kraken/driver.html?testName=audio-beat-detection) 04:14:22 INFO - PROCESS | 8937 | RSS: Main: 210718720 04:14:22 INFO - PROCESS | 8937 | 04:14:24 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58695/tests/kraken/driver.html?testName=audio-dft) 04:14:25 INFO - PROCESS | 8937 | RSS: Main: 198574080 04:14:25 INFO - PROCESS | 8937 | 04:14:28 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58695/tests/kraken/driver.html?testName=audio-fft) 04:14:29 INFO - PROCESS | 8937 | RSS: Main: 266760192 04:14:29 INFO - PROCESS | 8937 | 04:14:31 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58695/tests/kraken/driver.html?testName=audio-oscillator) 04:14:32 INFO - PROCESS | 8937 | RSS: Main: 177389568 04:14:32 INFO - PROCESS | 8937 | 04:14:34 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58695/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:14:35 INFO - PROCESS | 8937 | RSS: Main: 180404224 04:14:35 INFO - PROCESS | 8937 | 04:14:38 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58695/tests/kraken/driver.html?testName=imaging-darkroom) 04:14:39 INFO - PROCESS | 8937 | RSS: Main: 216592384 04:14:39 INFO - PROCESS | 8937 | 04:14:42 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58695/tests/kraken/driver.html?testName=imaging-desaturate) 04:14:43 INFO - PROCESS | 8937 | RSS: Main: 214798336 04:14:43 INFO - PROCESS | 8937 | 04:14:46 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58695/tests/kraken/driver.html?testName=json-parse-financial) 04:14:47 INFO - PROCESS | 8937 | RSS: Main: 215265280 04:14:47 INFO - PROCESS | 8937 | 04:14:49 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58695/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:14:49 INFO - PROCESS | 8937 | RSS: Main: 210296832 04:14:49 INFO - PROCESS | 8937 | 04:14:51 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58695/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:14:52 INFO - PROCESS | 8937 | RSS: Main: 213364736 04:14:52 INFO - PROCESS | 8937 | 04:14:54 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58695/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:14:55 INFO - PROCESS | 8937 | RSS: Main: 218398720 04:14:55 INFO - PROCESS | 8937 | 04:14:58 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:14:58 INFO - PROCESS | 8937 | RSS: Main: 220434432 04:14:58 INFO - PROCESS | 8937 | 04:15:01 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:15:02 INFO - PROCESS | 8937 | RSS: Main: 220516352 04:15:02 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | Cycle 1(1): loaded http://localhost:58695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58695/tests/kraken/driver.html?testName=ai-astar) 04:15:04 INFO - PROCESS | 8937 | RSS: Main: 267186176 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | __start_tp_report 04:15:04 INFO - PROCESS | 8937 | _x_x_mozilla_page_load 04:15:04 INFO - PROCESS | 8937 | _x_x_mozilla_page_load_details 04:15:04 INFO - PROCESS | 8937 | |i|pagename|runs| 04:15:04 INFO - PROCESS | 8937 | |0;ai-astar;113;110;114;113;115;115;117;114;115;115 04:15:04 INFO - PROCESS | 8937 | |1;audio-beat-detection;155;129;134;194;130;152;151;130;185;131 04:15:04 INFO - PROCESS | 8937 | |2;audio-dft;160;161;159;161;162;160;162;161;160;161 04:15:04 INFO - PROCESS | 8937 | |3;audio-fft;75;75;74;138;74;76;75;75;121;75 04:15:04 INFO - PROCESS | 8937 | |4;audio-oscillator;93;93;159;93;94;95;127;93;95;126 04:15:04 INFO - PROCESS | 8937 | |5;imaging-gaussian-blur;116;117;116;117;116;116;117;117;117;116 04:15:04 INFO - PROCESS | 8937 | |6;imaging-darkroom;147;145;145;146;145;146;146;146;146;145 04:15:04 INFO - PROCESS | 8937 | |7;imaging-desaturate;95;95;94;94;94;95;94;94;95;95 04:15:04 INFO - PROCESS | 8937 | |8;json-parse-financial;65;65;67;65;65;65;65;71;65;66 04:15:04 INFO - PROCESS | 8937 | |9;json-stringify-tinderbox;64;64;65;65;65;64;64;65;65;65 04:15:04 INFO - PROCESS | 8937 | |10;stanford-crypto-aes;83;81;82;82;83;83;85;85;141;84 04:15:04 INFO - PROCESS | 8937 | |11;stanford-crypto-ccm;129;132;130;136;136;131;139;128;154;138 04:15:04 INFO - PROCESS | 8937 | |12;stanford-crypto-pbkdf2;179;173;178;180;175;174;175;169;173;172 04:15:04 INFO - PROCESS | 8937 | |13;stanford-crypto-sha256-iterative;67;69;72;68;68;68;67;66;69;67 04:15:04 INFO - PROCESS | 8937 | __end_tp_report 04:15:04 INFO - PROCESS | 8937 | __start_cc_report 04:15:04 INFO - PROCESS | 8937 | _x_x_mozilla_cycle_collect,2075 04:15:04 INFO - PROCESS | 8937 | __end_cc_report 04:15:04 INFO - PROCESS | 8937 | __startTimestamp1464088504459__endTimestamp 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | ------- Summary: start ------- 04:15:04 INFO - PROCESS | 8937 | Number of tests: 14 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:1.85 (1.6%) stddev-sans-first:1.92 04:15:04 INFO - PROCESS | 8937 | Values: 113.0 110.0 114.0 113.0 115.0 115.0 117.0 114.0 115.0 115.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:151.50 stddev:23.67 (15.6%) stddev-sans-first:25.01 04:15:04 INFO - PROCESS | 8937 | Values: 155.0 129.0 134.0 194.0 130.0 152.0 151.0 130.0 185.0 131.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 04:15:04 INFO - PROCESS | 8937 | Values: 160.0 161.0 159.0 161.0 162.0 160.0 162.0 161.0 160.0 161.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#3] audio-fft Cycles:10 Average:85.80 Median:75.00 stddev:23.38 (31.2%) stddev-sans-first:24.47 04:15:04 INFO - PROCESS | 8937 | Values: 75.0 75.0 74.0 138.0 74.0 76.0 75.0 75.0 121.0 75.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.87 (24.6%) stddev-sans-first:23.70 04:15:04 INFO - PROCESS | 8937 | Values: 93.0 93.0 159.0 93.0 94.0 95.0 127.0 93.0 95.0 126.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:15:04 INFO - PROCESS | 8937 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 04:15:04 INFO - PROCESS | 8937 | Values: 147.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 04:15:04 INFO - PROCESS | 8937 | Values: 95.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.00 stddev:1.91 (2.9%) stddev-sans-first:2.00 04:15:04 INFO - PROCESS | 8937 | Values: 65.0 65.0 67.0 65.0 65.0 65.0 65.0 71.0 65.0 66.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 04:15:04 INFO - PROCESS | 8937 | Values: 64.0 64.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:83.00 stddev:18.35 (22.1%) stddev-sans-first:19.34 04:15:04 INFO - PROCESS | 8937 | Values: 83.0 81.0 82.0 82.0 83.0 83.0 85.0 85.0 141.0 84.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:136.00 stddev:7.62 (5.6%) stddev-sans-first:7.73 04:15:04 INFO - PROCESS | 8937 | Values: 129.0 132.0 130.0 136.0 136.0 131.0 139.0 128.0 154.0 138.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:175.00 stddev:3.39 (1.9%) stddev-sans-first:3.24 04:15:04 INFO - PROCESS | 8937 | Values: 179.0 173.0 178.0 180.0 175.0 174.0 175.0 169.0 173.0 172.0 04:15:04 INFO - PROCESS | 8937 | 04:15:04 INFO - PROCESS | 8937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.66 (2.4%) stddev-sans-first:1.72 04:15:04 INFO - PROCESS | 8937 | Values: 67.0 69.0 72.0 68.0 68.0 68.0 67.0 66.0 69.0 67.0 04:15:04 INFO - PROCESS | 8937 | -------- Summary: end -------- 04:15:04 INFO - PROCESS | 8937 | 04:15:05 INFO - TEST-INFO | 8937: exit 0 04:15:05 INFO - TEST-OK | kraken | took 65023ms 04:15:05 INFO - SUITE-END | took 1183s 04:15:05 INFO - Completed test suite (00:19:43) 04:15:05 INFO - javascript benchmark 04:15:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.7325267473248, 2683.838969661819, 2693.1381957773515, 2711.5661494160936, 2721.5101281769284, 4642.651801114913, 4676.228422310319, 4713.128071306811, 4754.738489383087, 4830.806767729291, 4682.859514214579, 4703.200455922492, 4706.176419126657, 4755.3104799804005, 4771.403574553181, 4116.711830171889, 4274.145170965804, 4351.5648435156545, 4385.364122202279, 4478.23869942109, 4388.144311859189, 4420.690551661369, 4426.933595996063, 4436.134953684033, 4469.329600559926, 4223.02870339822, 4267.722598031118, 4358.215521206182, 4379.75911324877, 4396.604305612478, 4328.978355108205, 4333.674974376934, 4339.175556644227, 4384.320430333303, 4397.824087036514, 4355.542668019844, 4362.36745671879, 4366.061296821199, 4386.0569977455, 4413.514513403523, 4577.473590537097, 4621.075784843045, 4650.0932318197965, 4678.859634210945, 4695.577398034194, 5124.666896651705, 5181.611379146579, 5188.351456067991, 5189.610779191538, 5191.351081114861, 5212.9739351303, 5222.060029194743, 5225.817096401645, 5232.555232805216, 5236.633435659505, 4680.9297860532115, 4684.320773487825, 4747.216709242936, 4753.524647535219, 4813.9037219256115, 5184.455632158644, 5208.583313334924, 5212.374515058217, 5213.348331458567, 5218.2955301034635, 4851.80592776285, 4950.752462376867, 4993.975030124826, 4997.400311962515, 4998.450170481244, 5058.696478211319, 5099.5410413063, 5102.107131252016, 5106.285120083191, 5129.333186685707, 5070.492950704974, 5109.693418394908, 5116.692998420107, 5119.257707632372, 5163.612729045337, 4863.537963893425, 4985.725785081855, 5091.389033316026, 5100.872478188075, 5109.054824857339, 4211.326187809936, 4248.702590818675, 4250.489941207075, 4269.530351661315, 4283.914321713548, 3720.9813950930616, 3748.2316125194816, 3752.6434988676033, 3779.3952967525065, 3784.791836449022, 4306.0526684129445, 4338.891527711769, 4357.607815296638, 4403.361512580658, 4410.911781764411, 5066.746662666852, 5103.923441148386, 5108.157154069611, 5108.846734597893, 5168.173092305288, 4382.978085109554, 4408.845690400884, 4414.646828253796, 4455.643548516111, 4459.264221403497, 4446.288593824973, 4528.6150677192145, 4546.659000574904, 4550.271956486946, 4558.111168322145, 4863.221884498605, 4867.099586576494, 4870.0, 4922.50774922512, 4924.285978533164, 5143.125668636416, 5143.794248230029, 5152.0, 5152.896942061213, 5159.974200128975, 4747.216709243075, 4751.619870410428, 4813.975930120467, 4829.927551086666, 4864.586510146677, 5021.372328458942, 5026.170681837456, 5036.697798132123, 5037.471065538066, 5081.517255860687, 5091.6181286402925, 5096.796128154981, 5099.056674515226, 5104.821331253388, 5107.565856902205, 4814.494478079751, 4887.853364399074, 4932.087563800708, 4939.382577177853, 4966.528179822911, 4904.190808516555, 4936.407631084293, 4942.925856112233, 4950.306957025947, 4983.576396006235, 4799.568038876518, 4879.585235255043, 4886.877828054327, 4890.853274401774, 4934.087193869145, 4965.379327584052, 4997.575206107522, 5005.224190250517, 5006.724630145377, 5012.523810238022, 4897.094037603055, 4901.558859702502, 4902.117618828645, 4927.482614325588, 4957.925631115609], "value": 4671.370008368358, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.7589850212162, 593.1014513012789, 593.2613895699855, 596.8179705189918, 610.7740136149624, 40607.39088913669, 42194.36708449372, 42270.99999999996, 46147.53852461474, 46148.769256153755, 40121.99695007626, 40483.59516404835, 40494.392584111185, 40607.79696101523, 40648.39027414591, 7794.3764498839955, 7935.285824275814, 7943.443958922878, 7952.045754509438, 7955.920440795576, 7867.645955931968, 7939.325157361631, 7944.483608565453, 7959.562224077674, 7960.442769006172, 7958.4031197660115, 8002.559859207741, 8017.599120044004, 8027.0, 8031.759047228593, 7901.288884000439, 7963.681452741884, 7978.2420670036545, 7978.242067003684, 7981.561014144219, 7865.488743231672, 7948.165442628499, 7957.761267161936, 7967.601619918981, 7969.083555391147, 39722.801385993174, 39966.0, 40036.19927601461, 40078.19843603141, 40109.78572785548, 3288.391647545212, 3290.7696461247724, 3762.435634654796, 3773.151041015777, 3868.2650296443867, 28470.145895623165, 28968.710312896812, 31200.37599248002, 31320.0, 32652.510212346835, 3465.5668041494814, 3578.320119177374, 3592.209713862946, 3708.369577171887, 3752.5309336332957, 261283.0, 266853.0, 267895.0, 268220.0, 268268.0, 49790.0, 51366.48633513692, 59196.40803591909, 60632.393676063555, 60861.69569152126, 62289.377106229265, 63017.68491157606, 63486.6825665878, 69508.6524567384, 69690.65154674296, 12601.369931503388, 12645.74708505843, 12737.235765854079, 12743.553975610808, 12744.553940612219, 7935.761927142195, 8974.237189838937, 9009.549522523848, 9054.139856713602, 9108.362414630912, 18941.0, 19623.769356416204, 19699.803001969798, 19770.60458790816, 19782.40652780419, 7363.410927125924, 7379.7048118075745, 7473.663685134182, 7631.732889348847, 7732.922670773332, 804.6982381606897, 886.9246114080375, 900.1763386501278, 949.1979277510493, 965.1892410375178, 28605.57091643627, 28717.856410718232, 29027.709722902502, 29379.265518361786, 29406.67669954857, 983.5573991703762, 985.0789511806483, 987.896270891546, 1030.9742256443649, 1037.5953378182514, 14999.325030373659, 15329.0, 15494.457693980656, 15706.0, 15838.12890291022, 366848.0, 370471.0, 371755.0, 372491.0, 372530.0, 50693.95836249837, 51097.233541496906, 51141.48858511441, 51297.743511282206, 51355.74322128366, 1115.6262652011667, 1190.547591915084, 1199.2984104298735, 1228.5331574001823, 1249.3940438887132, 28402.715972840833, 29761.5535766968, 29762.702372975993, 29820.552691709207, 30294.394112118076, 42892.0, 43320.0, 43944.78027609969, 43967.0, 43967.340489892034, 244055.0, 244429.0, 244792.0, 245104.0, 245430.0, 32910.670893290764, 37725.62274377331, 38829.2234155321, 38835.417468737425, 41516.37725434061, 42588.78705606576, 42880.14239715251, 43002.35496467618, 43573.56426435822, 43682.34476482919, 36500.0, 36949.445758314185, 37118.0, 37548.62451375451, 38058.809705951295, 36564.81717591395, 36632.26735465329, 36656.45015324719, 36951.076223094635, 37296.0, 35544.46683299804, 36470.452943205346, 36512.63487365199, 36690.44964325591, 36742.44886326654, 31385.686143139188, 32727.34545309033, 33219.50170747392, 33444.83277583597, 33517.497237541946, 25261.621075683513, 25632.359191020372, 25649.0, 25816.096436624626, 25871.48257034811], "value": 18055.852576594712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.6137771207096, 363.8290003698261, 366.3735013127551, 368.9797061161635, 382.69193299393993, 15674.608134796636, 16453.753193702105, 16844.0, 16853.662926741472, 17166.0, 14773.261336933165, 15547.0, 15654.608634784136, 15744.055356678578, 15768.211589420513, 5059.721715305656, 5276.709780962045, 5284.920726189111, 5285.207218917155, 5286.2070689396705, 3748.2128752961776, 3929.0, 5132.4610915853855, 5705.315362156547, 6045.093236014611, 6061.45446909778, 6075.574709770318, 6086.726097325631, 6103.938960610381, 6107.816765497042, 5921.171036054956, 6004.969975150118, 6062.514998800086, 6114.602550834204, 6119.66341851198, 3427.7943323400427, 5024.321716568253, 5262.184361423985, 5341.599380046512, 5349.090654588729, 19649.312274070482, 20178.19287228509, 20201.494962625904, 20549.4862628434, 20586.0, 1898.2786541114426, 2002.9699554506694, 2008.2870580943847, 2098.1187901081585, 2513.8743062846784, 12747.872521274761, 12776.488940442372, 12959.740805183937, 13038.739225215537, 13219.669508262274, 1697.8896371735798, 1749.3702267183803, 1776.4936992956946, 1782.322717367405, 1799.7210432383001, 67173.3282667172, 67471.0, 70516.29483705148, 70910.0, 71211.64394178048, 10153.949230253802, 10183.949080254552, 10188.337758045851, 10205.489725513695, 10408.167346612252, 14322.212278324583, 14365.7845132321, 14374.640633984234, 14403.063800852911, 14422.711545769025, 6681.265060843303, 6688.331166883273, 6752.662366881735, 6818.590884546943, 6871.694378068151, 6177.505799536027, 6205.193324867829, 6306.432421082125, 6327.620342779356, 6329.177206963065, 4369.497507786582, 4480.596746292849, 4512.390827238347, 4538.863834084983, 4581.266997280419, 1491.9104853708811, 1587.547548948544, 1599.3122957128546, 1672.9163541823104, 1706.9487915362558, 847.588919374103, 866.6490071521044, 868.7610907000499, 909.8680691299725, 914.2274777812737, 16435.67128657444, 16689.582760431087, 16779.83220167807, 17119.91440042792, 17125.743113853303, 891.5586784541694, 903.1645727701849, 904.6833608237196, 910.7677542226822, 939.0890835889177, 8087.474314169678, 9583.137517623447, 9604.471754053595, 9620.278479113955, 9710.611575537041, 387970.0, 393255.0, 395298.0, 411647.0, 411829.0, 73157.26842731611, 73838.63080684563, 74810.25189748032, 75705.0, 76782.0, 880.8898887639045, 886.8980067292345, 897.8473659477904, 899.1862364560084, 904.69692652962, 15043.097414155185, 15511.84488155104, 15980.840191597936, 16105.114218718083, 16136.838631613533, 34173.825616930386, 34174.0, 35424.46863297001, 35427.291454170256, 35769.82115089408, 48119.5188048115, 48155.75922120507, 50448.24327635162, 50584.494155057975, 51344.0, 7216.603086830065, 7357.742479013209, 7376.557406555624, 7470.252974702486, 7561.735339263099, 7885.250901164381, 9845.556949937414, 10574.524146413583, 11186.440677966231, 11220.99011089006, 9020.639174432948, 9094.090590940854, 9461.763455913657, 9546.331756776959, 9632.373895696757, 9376.29677774156, 9379.062093790566, 9394.906050939404, 9575.138237558374, 9701.272404569545, 9397.0, 9482.573284202366, 9670.323077384515, 9958.203343732628, 10079.294449388472, 6346.111544383883, 7071.151461824614, 7091.893621595577, 7279.365679437427, 7471.551706897603, 8119.188081191834, 9578.9042109578, 9661.758456038655, 9889.604415823575, 10231.28381013322], "value": 8112.33723449661, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.0396100943797, 1355.7559639264935, 1410.7108042851214, 1462.7659574468087, 1700.0, 6290.748370065197, 7139.500234983553, 7349.228331025246, 7380.298871607195, 7535.660895259713, 7339.449541284398, 7408.777736667895, 7465.738699145531, 7473.4394920381055, 7479.439042071853, 2125.3092744857945, 2151.9892400537974, 2154.881481518516, 2154.9461263468384, 2155.2348916134783, 2100.338393406072, 2124.4370241885913, 2181.301983365324, 2181.5418762059985, 2183.1376606240524, 2118.1315660579166, 2131.5949969505746, 2144.8176904963098, 2146.957060858782, 2147.8281737461043, 2118.9682154767693, 2119.745630524339, 2124.022949443258, 2126.415235810157, 2127.0322003488377, 2036.745406824147, 2101.2120454829437, 2105.3473423238843, 2108.262108262096, 2109.715188449555, 7363.263673632648, 7387.298206670358, 7394.223606521292, 7396.630168491554, 7600.239976002355, 4153.273177193979, 4208.032152604918, 4241.957580424187, 4251.87244382669, 4256.2338779019765, 2837.957430638542, 2855.457463082008, 2877.007432435806, 2908.1420980810713, 2909.8254104753782, 901.9819603607957, 910.6812615584493, 911.7173676160412, 915.272358475014, 916.9266458683289, 10128.240381971382, 10237.078662920298, 10279.0, 10297.433641149733, 10300.690979270634, 3838.5201849768778, 3939.901502462404, 4002.9799851000557, 4006.759594424344, 4071.8371265149062, 8131.552764598004, 8141.9185808141165, 8169.2647661710735, 8188.7952801180445, 8190.549519776469, 4171.311733563928, 4180.393842892763, 4182.895427614334, 4184.225918205142, 4187.602177793105, 3320.8007519548905, 3653.7990410527145, 3782.319182547113, 3841.9231615368094, 3909.0618251619976, 3248.853801578887, 3252.5609042778924, 3318.1870441741926, 3340.816255105944, 3428.6914177724125, 964.7732782796037, 978.4031740638205, 979.1041197304387, 1012.4937531234383, 1018.8777346718441, 678.864227154571, 786.2216405758259, 808.9676412943417, 811.2860682599393, 833.8582440985047, 4861.489543597942, 4938.08645400602, 5018.272350509155, 5045.571126454219, 5108.7190204538365, 390.10081761539357, 397.16595150184384, 399.1279055264257, 400.23355274649305, 405.49313358302123, 3387.136280248521, 3435.9484607730906, 3444.8794292200155, 3460.100373902753, 3520.0495866116007, 8857.424267422597, 9262.027487113755, 9369.437833729999, 9369.765755856159, 9385.38994965325, 9211.124943130391, 9231.446113233227, 9239.168474837297, 9244.16802487766, 9244.260459163252, 6835.58986460814, 6877.724891004304, 6888.070110535114, 6903.309669033157, 6904.585724856524, 4862.367892173995, 4961.107000739901, 5014.297998280316, 5066.594672426123, 5071.492850714899, 8599.53807852654, 8608.48349099056, 8609.956950215208, 8672.696455624024, 8700.347473939353, 7769.844603108019, 7978.481398709066, 8014.318782903285, 8254.174582541698, 8778.122187781171, 5769.538436924952, 6151.538634602333, 6264.843378915381, 6349.14286571307, 6362.554621176473, 6979.511434199558, 7235.963820180866, 7242.456815738736, 7244.022057022235, 7244.673989670583, 6486.027520415666, 6677.833054173684, 6685.498587606046, 6724.529282950147, 6735.191776986793, 6519.445847103049, 6553.672316384066, 6624.403803657694, 6657.800265992028, 6709.060731497497, 5985.940140598713, 6021.729022193924, 6043.2748070231855, 6045.365236650088, 6046.697665116639, 4392.275274579786, 4405.911881762411, 4433.623142032834, 4523.348977623078, 4534.659900507541, 4357.694961352801, 4417.757023363617, 4481.103779244229, 4510.977445112753, 4548.0221752323405], "value": 3852.972601719259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.70910253336524, 279.94401119776046, 284.8063316944478, 288.052307906986, 288.6103759924101, 4800.9759951200285, 4802.223177424354, 4805.663603547749, 4818.855434336967, 4853.840041181676, 4770.809167633299, 4784.784684689189, 4789.281607758838, 4789.66472346935, 4802.207635740107, 3564.8770637249313, 3667.743257971943, 3669.5229620149344, 3772.77363358198, 3793.6965042796646, 3741.7380783345175, 3749.400095984643, 3761.8683346082894, 3781.508403907502, 3791.393377059671, 3536.133647256426, 3740.3828368319196, 3745.2322273933914, 3753.643403876641, 3757.4739536464917, 3652.7443078984484, 3728.8881333560034, 3734.439834024891, 3738.8504459821847, 3753.0429740416293, 3310.6027276726704, 3312.5528053712683, 3315.270640459095, 3322.5680661513848, 3324.1523411530147, 4474.597286244254, 4476.574725401114, 4500.457241658485, 4521.033350492547, 4540.772961351952, 3995.6215105788456, 4205.476713971592, 4226.562968590663, 4238.131183107455, 4243.893902652428, 4950.7029578225065, 4958.8760280993265, 4963.131451995886, 4983.252512123175, 4984.451710311862, 3389.9660603515918, 3532.6467353264725, 3535.5757309122814, 3550.5384300041087, 3566.28674265148, 5112.079825631385, 5128.358955130609, 5136.64043516954, 5143.537081662631, 5152.072626927152, 3560.1989552351033, 3567.714582833367, 3579.3736096183065, 3583.104223944014, 3589.3000864831106, 3637.7999210043704, 3646.781193128421, 3649.525561676965, 3656.7623104498653, 3666.5233519642275, 3923.6861051115843, 4188.4136220929095, 4196.370544418301, 4196.832126714959, 4208.095259519218, 4952.158133117378, 4962.131626965339, 4973.45292017885, 4979.0, 4990.579568909076, 1244.993775031119, 1258.3205069262679, 1265.0322503284995, 1268.9873101269054, 1269.3906924676207, 787.9172686867911, 822.7284995951321, 893.5308962794585, 906.5059542549326, 923.6720964057797, 4336.371226172188, 4395.758233297135, 4398.64810815134, 4400.537943515948, 4405.207062728676, 5000.649954503223, 5028.321176641107, 5049.267856160836, 5066.797328106834, 5069.746512674352, 4216.768077755692, 4350.891227719332, 4365.3670217818235, 4373.825046998085, 4397.790607582876, 2655.5618322976493, 2679.767307038745, 2682.2757855379327, 2693.6363590915366, 2695.9056433025144, 4801.591864691471, 4809.302651115569, 4814.737073575414, 4821.807127714922, 4832.347633069561, 4938.555530002317, 5138.0, 5145.845624631267, 5146.614003949719, 5238.5547228486, 4847.660663753574, 4859.125357435625, 4866.148424025781, 4868.829590964299, 4883.487233840538, 5128.461511541234, 5135.229715542699, 5137.743112844418, 5146.8970620588125, 5163.3545806774155, 4794.352762377034, 4998.5754060092695, 5006.224035274538, 5023.0, 5031.773570189277, 4807.302941073594, 4864.829730959399, 4866.245731911559, 4867.515407800654, 4896.706197628154, 3572.2319701264355, 3597.586277578112, 3659.645931005545, 3666.908327291839, 3677.558692956862, 4994.925076123934, 5152.201408781645, 5195.766190521511, 5199.610029247746, 5205.219217117311, 4988.9251661225835, 5005.0, 5006.374203224597, 5010.549050585319, 5020.297158397754, 4996.725180115129, 5006.148954677787, 5015.523525265094, 5021.698698078127, 5026.396832380138, 4648.395708557866, 4867.659263851497, 4915.508449155056, 4951.628627852853, 4973.825916092919, 4774.331593576832, 4876.731779752147, 4982.775775090057, 4995.925061124013, 5029.346184995927, 4882.658213924991, 4890.0, 4899.975500122477, 4902.852914412573, 4937.728424936663], "value": 3745.1305571668713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4186289640065, 641.0960545630659, 697.0728930522406, 700.4221517248271, 740.7148247924547, 10614.150867930566, 11739.589114380988, 12510.562130325452, 12513.812292815604, 12827.294498802563, 11959.103067269945, 12459.878610925014, 12596.559120430788, 12716.364181790897, 12722.554710585131, 802.7391097893194, 815.8409110223508, 816.808050108224, 817.1134319263606, 817.8977627796526, 625.7184267079809, 773.9226077392273, 816.2123550773503, 816.7590560784582, 817.0971076959963, 851.9275861551776, 852.5353682243161, 854.3848429131016, 854.5983387807752, 854.8931383577053, 841.5707988925631, 847.5931552854634, 848.0501837941483, 849.6176720475748, 849.8257857139303, 623.5541587764725, 624.3818619566641, 624.5784095735361, 624.753222477119, 624.8250489862845, 11452.427378631035, 11462.598809041727, 11478.94260528692, 11480.196386252966, 11494.827577586342, 12089.879101208964, 12360.320182389965, 12553.121281510297, 12602.873971260262, 12645.873541264562, 9844.276387053207, 9962.203023758155, 10168.847467287997, 10344.22418318629, 10419.479026048668, 3244.9675503244903, 3277.3936821687826, 3320.7841490303294, 3352.3127758809387, 3375.1730825947557, 45723.31415028777, 45945.770271148765, 46032.309515357294, 46103.76948115272, 46395.0, 9795.07398024185, 9916.25628077897, 9974.650887218913, 9999.300048996645, 10022.398656080659, 17652.558686032953, 17655.38206162804, 17699.38052168194, 17718.379856704953, 17742.467725968243, 6370.076338930921, 6539.313372095957, 6587.80236592903, 6629.436497897636, 6669.1330127083165, 3670.4310831820576, 3689.7048236141045, 3708.42519409492, 3713.164537978933, 3735.495708079429, 2605.557055300603, 2696.32591852037, 2706.796990225741, 2707.0, 2709.5122877881777, 477.31266975555087, 479.90641824843823, 495.0495049504887, 498.5961371289267, 552.2296396526823, 477.5773440505109, 492.8496808473378, 545.3237984898776, 569.2542768972659, 571.1062187676356, 8308.70919517826, 8474.5339006354, 8495.447795893248, 8645.0, 8711.60797764102, 606.5087279303779, 620.5749061892618, 623.9313675495691, 635.2789583822395, 647.6243778608396, 4003.979980100081, 4284.592963668447, 4290.120525292307, 4341.82632694695, 4406.735595864258, 56409.435905641236, 57103.0, 57429.712851436314, 57453.0, 57918.4208157913, 55218.72390638021, 55905.720471397384, 55951.720241398536, 55969.440305597236, 56174.7191264041, 49726.502734972186, 50033.499665002884, 50274.74862625664, 50618.999999999265, 50663.0, 8373.49759014461, 8420.073791883011, 8478.703245386629, 8524.062353141026, 8612.397132200686, 32481.0, 33056.83471582627, 33750.83124584361, 33940.66059339375, 33987.3202535943, 30944.69055309418, 39504.60495395009, 43518.0, 45458.0, 46037.76981115207, 10454.58181672755, 10583.4708264588, 10984.725381865517, 11075.501602428072, 11076.280041797258, 11861.76276474483, 11994.400279986141, 12351.38243087824, 12359.567415140427, 12826.23042617446, 11108.277961932448, 11346.432678365883, 11655.59205427806, 11686.065114790967, 11769.588064417705, 11403.942980285046, 11414.258073225214, 11525.193236473366, 11671.708207294885, 12344.753104937672, 10746.946265268623, 10802.081823044815, 11277.887221127683, 11764.647060588197, 11794.174407791372, 9507.0, 9733.318667693193, 9994.60021599157, 10014.949925250326, 10039.247056470647, 9735.22118230554, 9814.116729494379, 9923.751906202402, 9929.254311609187, 10037.498125093862], "value": 6078.204752969803, "unit": "score"}], "name": "dromaeo_css", "value": 6257.2491896160755, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 114.0, 113.0, 115.0, 115.0, 117.0, 114.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 134.0, 194.0, 130.0, 152.0, 151.0, 130.0, 185.0, 131.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 161.0, 162.0, 160.0, 162.0, 161.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 138.0, 74.0, 76.0, 75.0, 75.0, 121.0, 75.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 159.0, 93.0, 94.0, 95.0, 127.0, 93.0, 95.0, 126.0], "value": 106.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0, 71.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 82.0, 83.0, 83.0, 85.0, 85.0, 141.0, 84.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 130.0, 136.0, 136.0, 131.0, 139.0, 128.0, 154.0, 138.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 178.0, 180.0, 175.0, 174.0, 175.0, 169.0, 173.0, 172.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 72.0, 68.0, 68.0, 68.0, 67.0, 66.0, 69.0, 67.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1570.8, "alertThreshold": 2.0}]} 04:15:05 INFO - Return code: 0 04:15:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:15:05 ERROR - # TBPL SUCCESS # 04:15:05 INFO - Running post-action listener: _resource_record_post_action 04:15:05 INFO - ##### 04:15:05 INFO - ##### Finished run-tests step (success) 04:15:05 INFO - ##### 04:15:05 INFO - Running post-run listener: _resource_record_post_run 04:15:05 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 532090880; Read time: 16; Write time: 382160 04:15:05 INFO - TinderboxPrint: CPU usage
13.0% 04:15:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 04:15:05 INFO - TinderboxPrint: I/O write bytes / time
532,090,880 / 382,160 04:15:05 INFO - TinderboxPrint: CPU idle
8,327.8 (86.9%) 04:15:05 INFO - TinderboxPrint: CPU user
1,210.0 (12.6%) 04:15:05 INFO - TinderboxPrint: Swap in / out
0 / 0 04:15:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 136081408; Read time: 0; Write time: 122552 04:15:05 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295219200; Read time: 16; Write time: 186260 04:15:06 INFO - Running post-run listener: _upload_blobber_files 04:15:06 INFO - Blob upload gear active. 04:15:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:15:06 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 04:15:06 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'] 04:15:06 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 04:15:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:07 INFO - (blobuploader) - INFO - Done attempting. 04:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:11 INFO - (blobuploader) - INFO - Done attempting. 04:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:12 INFO - (blobuploader) - INFO - Done attempting. 04:15:12 INFO - (blobuploader) - INFO - Iteration through files over. 04:15:12 INFO - Return code: 0 04:15:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:15:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:15:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12bc1dbe86c0f2dc8e1dcf5ddb6a57bc3edaf8ca89d2a5a6b711f0c619ca411030e5e6e8322881acfb26629cd6df61e00a29308a746db546668f1617830e2968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/929177c67fca435ec4dd39944dbd372baa0f8df60182c9584ae13e4795660f604ef443ec863b9206193ae3bc6d41877f6adc77410a7f79bc2e5e9053eecd1922", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd52830a8399f0e3ce07440165005be1ea25d35785ab96f4e29930e309ae26f3caf275484838945b28837e56ec561a4cacd50a8eb3a259fbd3d10582b65ff92e"} 04:15:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:15:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:15:12 INFO - Contents: 04:15:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12bc1dbe86c0f2dc8e1dcf5ddb6a57bc3edaf8ca89d2a5a6b711f0c619ca411030e5e6e8322881acfb26629cd6df61e00a29308a746db546668f1617830e2968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/929177c67fca435ec4dd39944dbd372baa0f8df60182c9584ae13e4795660f604ef443ec863b9206193ae3bc6d41877f6adc77410a7f79bc2e5e9053eecd1922", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd52830a8399f0e3ce07440165005be1ea25d35785ab96f4e29930e309ae26f3caf275484838945b28837e56ec561a4cacd50a8eb3a259fbd3d10582b65ff92e"} 04:15:12 INFO - Running post-run listener: copy_logs_to_upload_dir 04:15:12 INFO - Copying logs to upload dir... 04:15:12 INFO - mkdir: /builds/slave/test/build/upload/logs 04:15:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.219501 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-05-24 04:15:12.877756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 04:15:12.884905) ========= 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=ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675 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/12bc1dbe86c0f2dc8e1dcf5ddb6a57bc3edaf8ca89d2a5a6b711f0c619ca411030e5e6e8322881acfb26629cd6df61e00a29308a746db546668f1617830e2968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/929177c67fca435ec4dd39944dbd372baa0f8df60182c9584ae13e4795660f604ef443ec863b9206193ae3bc6d41877f6adc77410a7f79bc2e5e9053eecd1922", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd52830a8399f0e3ce07440165005be1ea25d35785ab96f4e29930e309ae26f3caf275484838945b28837e56ec561a4cacd50a8eb3a259fbd3d10582b65ff92e"} build_url:https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/K6DCU1ZnTCyfkNOsUNja3A/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/12bc1dbe86c0f2dc8e1dcf5ddb6a57bc3edaf8ca89d2a5a6b711f0c619ca411030e5e6e8322881acfb26629cd6df61e00a29308a746db546668f1617830e2968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/929177c67fca435ec4dd39944dbd372baa0f8df60182c9584ae13e4795660f604ef443ec863b9206193ae3bc6d41877f6adc77410a7f79bc2e5e9053eecd1922", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd52830a8399f0e3ce07440165005be1ea25d35785ab96f4e29930e309ae26f3caf275484838945b28837e56ec561a4cacd50a8eb3a259fbd3d10582b65ff92e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 04:15:12.909442) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:15:12.909787) ========= 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=ed14279e38b05397cf4aa391000001a4-1464087099.720864-678504675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:15:12.994381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 04:15:12.994719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 04:15:12.994999) ========= ========= Total master_lag: 0.19 =========