builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1460005151.34 results: success (0) buildid: 20160406211248 builduid: bd46f513ec404f40bb8b72990fc7307c revision: 8fc46323cee61bddc4c38701d6020379bba5774a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.344301) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.345266) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.346808) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006357 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.412602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.412955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.455447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.455788) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.504506) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.504835) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.505254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.505572) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 21:59:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.1M=0s 2016-04-06 21:59:12 (39.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.667615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.668584) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017825 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.724830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:11.725738) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8fc46323cee61bddc4c38701d6020379bba5774a --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 8fc46323cee61bddc4c38701d6020379bba5774a --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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 21:59:12,183 truncating revision to first 12 chars 2016-04-06 21:59:12,183 Setting DEBUG logging. 2016-04-06 21:59:12,183 attempt 1/10 2016-04-06 21:59:12,183 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8fc46323cee6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 21:59:12,519 unpacking tar archive at: fx-team-8fc46323cee6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661497 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:12.404260) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:12.405095) ========= echo 8fc46323cee61bddc4c38701d6020379bba5774a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8fc46323cee61bddc4c38701d6020379bba5774a'] 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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8fc46323cee61bddc4c38701d6020379bba5774a program finished with exit code 0 elapsedTime=0.004729 script_repo_revision: '8fc46323cee61bddc4c38701d6020379bba5774a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:12.461655) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:12.462387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 21:59:12.473859) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-06 21:59:12.474428) ========= /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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:13 INFO - MultiFileLogger online at 20160406 21:59:13 in /builds/slave/test 21:59:13 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 21:59:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:13 INFO - {'append_to_log': False, 21:59:13 INFO - 'base_work_dir': '/builds/slave/test', 21:59:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:59:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:13 INFO - 'branch': 'Fx-Team-Non-PGO', 21:59:13 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:13 INFO - 'config_files': ('talos/linux_config.py',), 21:59:13 INFO - 'default_actions': ('clobber', 21:59:13 INFO - 'read-buildbot-config', 21:59:13 INFO - 'download-and-extract', 21:59:13 INFO - 'populate-webroot', 21:59:13 INFO - 'create-virtualenv', 21:59:13 INFO - 'install', 21:59:13 INFO - 'run-tests'), 21:59:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:13 INFO - 'download_minidump_stackwalk': True, 21:59:13 INFO - 'download_symbols': 'ondemand', 21:59:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:13 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:13 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:13 INFO - 'installer_path': 'installer.exe', 21:59:13 INFO - 'log_level': 'info', 21:59:13 INFO - 'log_name': 'talos', 21:59:13 INFO - 'log_to_console': True, 21:59:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:13 INFO - 'opt_config_files': (), 21:59:13 INFO - 'pip_index': False, 21:59:13 INFO - 'sps_profile': False, 21:59:13 INFO - 'sps_profile_interval': 0, 21:59:13 INFO - 'suite': 'dromaeojs', 21:59:13 INFO - 'system_bits': '32', 21:59:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:13 INFO - 'title': 'talos-linux64-ix-001', 21:59:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:13 INFO - 'use_talos_json': True, 21:59:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:13 INFO - 'work_dir': 'build'} 21:59:13 INFO - ##### 21:59:13 INFO - ##### Running clobber step. 21:59:13 INFO - ##### 21:59:13 INFO - Running pre-action listener: _resource_record_pre_action 21:59:13 INFO - Running main action method: clobber 21:59:13 INFO - rmtree: /builds/slave/test/build 21:59:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:13 INFO - Running post-action listener: _resource_record_post_action 21:59:13 INFO - ##### 21:59:13 INFO - ##### Running read-buildbot-config step. 21:59:13 INFO - ##### 21:59:13 INFO - Running pre-action listener: _resource_record_pre_action 21:59:13 INFO - Running main action method: read_buildbot_config 21:59:13 INFO - Using buildbot properties: 21:59:13 INFO - { 21:59:13 INFO - "project": "", 21:59:13 INFO - "product": "firefox", 21:59:13 INFO - "script_repo_revision": "production", 21:59:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:59:13 INFO - "repository": "", 21:59:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:59:13 INFO - "buildid": "20160406211248", 21:59:13 INFO - "pgo_build": "False", 21:59:13 INFO - "basedir": "/builds/slave/test", 21:59:13 INFO - "buildnumber": 2775, 21:59:13 INFO - "slavename": "talos-linux64-ix-001", 21:59:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:59:13 INFO - "platform": "ubuntu64_hw", 21:59:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:59:13 INFO - "branch": "fx-team", 21:59:13 INFO - "repo_path": "integration/fx-team", 21:59:13 INFO - "revision": "8fc46323cee61bddc4c38701d6020379bba5774a", 21:59:13 INFO - "stage_platform": "linux64", 21:59:13 INFO - "builduid": "bd46f513ec404f40bb8b72990fc7307c", 21:59:13 INFO - "slavebuilddir": "test" 21:59:13 INFO - } 21:59:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:59:13 INFO - Running post-action listener: _resource_record_post_action 21:59:13 INFO - ##### 21:59:13 INFO - ##### Running download-and-extract step. 21:59:13 INFO - ##### 21:59:13 INFO - Running pre-action listener: _resource_record_pre_action 21:59:13 INFO - Running main action method: download_and_extract 21:59:13 INFO - mkdir: /builds/slave/test/build/tests 21:59:13 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')]} 21:59:13 INFO - https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:59:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:59:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:59:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:59:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:59:19 INFO - Downloaded 1361 bytes. 21:59:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:59:19 INFO - Using the following test package requirements: 21:59:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:19 INFO - u'jsshell-linux-x86_64.zip'], 21:59:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:19 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')]} 21:59:19 INFO - https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:59:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:59:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:59:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:30 INFO - Downloaded 22136277 bytes. 21:59:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:59:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:59:32 INFO - Return code: 0 21:59:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:59:32 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')]} 21:59:32 INFO - https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:35 INFO - Downloaded 22136277 bytes. 21:59:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:59:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:59:36 INFO - Return code: 0 21:59: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')]} 21:59:36 INFO - https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:59:37 INFO - Downloaded 10847617 bytes. 21:59:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:59:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:59:37 INFO - Return code: 0 21:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:37 INFO - https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:59:39 INFO - Downloaded 54197036 bytes. 21:59:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:59:39 INFO - mkdir: /builds/slave/test/properties 21:59:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:39 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:39 INFO - Contents: 21:59:39 INFO - build_url:https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:59:40 INFO - Running post-action listener: _resource_record_post_action 21:59:40 INFO - Running post-action listener: set_extra_try_arguments 21:59:40 INFO - ##### 21:59:40 INFO - ##### Running populate-webroot step. 21:59:40 INFO - ##### 21:59:40 INFO - Running pre-action listener: _resource_record_pre_action 21:59:40 INFO - Running main action method: populate_webroot 21:59:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:40 INFO - '--tppagecycles', 21:59:40 INFO - '7'], 21:59:40 INFO - 'tests': ['tsvgm']}}, 21:59:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:40 INFO - 'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:40 INFO - 'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['damp', 'tps']}, 21:59:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:40 INFO - 'tests': ['damp', 'tps']}, 21:59:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['dromaeo_dom']}, 21:59:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['a11yr', 21:59:40 INFO - 'ts_paint', 21:59:40 INFO - 'tpaint', 21:59:40 INFO - 'sessionrestore', 21:59:40 INFO - 'sessionrestore_no_auto_restore', 21:59:40 INFO - 'tabpaint']}, 21:59:40 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:40 INFO - 'ts_paint', 21:59:40 INFO - 'tpaint', 21:59:40 INFO - 'sessionrestore', 21:59:40 INFO - 'sessionrestore_no_auto_restore', 21:59:40 INFO - 'tabpaint']}, 21:59:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:40 INFO - 'ts_paint', 21:59:40 INFO - 'tpaint', 21:59:40 INFO - 'sessionrestore', 21:59:40 INFO - 'sessionrestore_no_auto_restore', 21:59:40 INFO - 'tabpaint']}, 21:59:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:40 INFO - 'ts_paint', 21:59:40 INFO - 'tpaint', 21:59:40 INFO - 'sessionrestore', 21:59:40 INFO - 'sessionrestore_no_auto_restore', 21:59:40 INFO - 'tabpaint']}, 21:59:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['a11yr', 21:59:40 INFO - 'ts_paint', 21:59:40 INFO - 'tpaint', 21:59:40 INFO - 'sessionrestore', 21:59:40 INFO - 'sessionrestore_no_auto_restore', 21:59:40 INFO - 'tabpaint']}, 21:59:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['a11yr', 21:59:40 INFO - 'ts_paint', 21:59:40 INFO - 'tpaint', 21:59:40 INFO - 'sessionrestore', 21:59:40 INFO - 'sessionrestore_no_auto_restore', 21:59:40 INFO - 'tabpaint']}, 21:59:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['tsvgx', 21:59:40 INFO - 'tsvgr_opacity', 21:59:40 INFO - 'tart', 21:59:40 INFO - 'tscrollx', 21:59:40 INFO - 'cart']}, 21:59:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:40 INFO - 'tsvgr_opacity', 21:59:40 INFO - 'tart', 21:59:40 INFO - 'tscrollx', 21:59:40 INFO - 'cart']}, 21:59:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:40 INFO - 'talos_options': ['--disable-e10s'], 21:59:40 INFO - 'tests': ['tp5o']}, 21:59:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:40 INFO - 'tests': ['tp5o']}, 21:59:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:40 INFO - 'talos_options': ['--disable-e10s', 21:59:40 INFO - '--xperf_path', 21:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:40 INFO - 'tests': ['tp5n']}, 21:59:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:40 INFO - 'talos_options': ['--xperf_path', 21:59:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:40 INFO - 'tests': ['tp5n']}}, 21:59:40 INFO - 'talos.zip': {'path': '', 21:59:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:40 INFO - Running post-action listener: _resource_record_post_action 21:59:40 INFO - ##### 21:59:40 INFO - ##### Running create-virtualenv step. 21:59:40 INFO - ##### 21:59:40 INFO - Running pre-action listener: _resource_record_pre_action 21:59:40 INFO - Running main action method: create_virtualenv 21:59:40 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59: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 21:59:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:40 INFO - Using real prefix '/usr' 21:59:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:41 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:43 INFO - Installing pip.................done. 21:59:43 INFO - Return code: 0 21:59:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', '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 21:59: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 21:59: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 21:59:43 INFO - Using env: {'DISPLAY': ':0', 21:59:43 INFO - 'HOME': '/home/cltbld', 21:59:43 INFO - 'LANG': 'en_US.UTF-8', 21:59:43 INFO - 'LANGUAGE': 'en_US:en', 21:59:43 INFO - 'LOGNAME': 'cltbld', 21:59:43 INFO - 'MAIL': '/var/mail/cltbld', 21:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:43 INFO - 'MOZ_NO_REMOTE': '1', 21:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:43 INFO - 'NO_EM_RESTART': '1', 21:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:43 INFO - 'PWD': '/builds/slave/test', 21:59:43 INFO - 'SHELL': '/bin/bash', 21:59:43 INFO - 'SHLVL': '1', 21:59:43 INFO - 'TERM': 'linux', 21:59:43 INFO - 'TMOUT': '86400', 21:59:43 INFO - 'USER': 'cltbld', 21:59:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 21:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:43 INFO - '_': '/tools/buildbot/bin/python'} 21:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59: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 21:59:43 INFO - Cleaning up... 21:59:43 INFO - Return code: 0 21:59:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', '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 21:59: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>=0.7.1'] in /builds/slave/test/build 21:59: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>=0.7.1 21:59:43 INFO - Using env: {'DISPLAY': ':0', 21:59:43 INFO - 'HOME': '/home/cltbld', 21:59:43 INFO - 'LANG': 'en_US.UTF-8', 21:59:43 INFO - 'LANGUAGE': 'en_US:en', 21:59:43 INFO - 'LOGNAME': 'cltbld', 21:59:43 INFO - 'MAIL': '/var/mail/cltbld', 21:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:43 INFO - 'MOZ_NO_REMOTE': '1', 21:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:43 INFO - 'NO_EM_RESTART': '1', 21:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:43 INFO - 'PWD': '/builds/slave/test', 21:59:43 INFO - 'SHELL': '/bin/bash', 21:59:43 INFO - 'SHLVL': '1', 21:59:43 INFO - 'TERM': 'linux', 21:59:43 INFO - 'TMOUT': '86400', 21:59:43 INFO - 'USER': 'cltbld', 21:59:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 21:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:43 INFO - '_': '/tools/buildbot/bin/python'} 21:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:43 INFO - Downloading/unpacking psutil>=0.7.1 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:45 INFO - Installing collected packages: psutil 21:59:45 INFO - Running setup.py install for psutil 21:59:45 INFO - building 'psutil._psutil_linux' extension 21:59: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 21:59: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 21:59:45 INFO - building 'psutil._psutil_posix' extension 21:59: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 21:59: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 21:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:46 INFO - Successfully installed psutil 21:59:46 INFO - Cleaning up... 21:59:46 INFO - Return code: 0 21:59:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', '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 21:59: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.0.0'] in /builds/slave/test/build 21:59: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.0.0 21:59:46 INFO - Using env: {'DISPLAY': ':0', 21:59:46 INFO - 'HOME': '/home/cltbld', 21:59:46 INFO - 'LANG': 'en_US.UTF-8', 21:59:46 INFO - 'LANGUAGE': 'en_US:en', 21:59:46 INFO - 'LOGNAME': 'cltbld', 21:59:46 INFO - 'MAIL': '/var/mail/cltbld', 21:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:46 INFO - 'MOZ_NO_REMOTE': '1', 21:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:46 INFO - 'NO_EM_RESTART': '1', 21:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:46 INFO - 'PWD': '/builds/slave/test', 21:59:46 INFO - 'SHELL': '/bin/bash', 21:59:46 INFO - 'SHLVL': '1', 21:59:46 INFO - 'TERM': 'linux', 21:59:46 INFO - 'TMOUT': '86400', 21:59:46 INFO - 'USER': 'cltbld', 21:59:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 21:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:46 INFO - '_': '/tools/buildbot/bin/python'} 21:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:59:48 INFO - Installing collected packages: mozsystemmonitor 21:59:48 INFO - Running setup.py install for mozsystemmonitor 21:59:48 INFO - Successfully installed mozsystemmonitor 21:59:48 INFO - Cleaning up... 21:59:48 INFO - Return code: 0 21:59:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', '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 21:59: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 21:59: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 21:59:48 INFO - Using env: {'DISPLAY': ':0', 21:59:48 INFO - 'HOME': '/home/cltbld', 21:59:48 INFO - 'LANG': 'en_US.UTF-8', 21:59:48 INFO - 'LANGUAGE': 'en_US:en', 21:59:48 INFO - 'LOGNAME': 'cltbld', 21:59:48 INFO - 'MAIL': '/var/mail/cltbld', 21:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:48 INFO - 'MOZ_NO_REMOTE': '1', 21:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:48 INFO - 'NO_EM_RESTART': '1', 21:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:48 INFO - 'PWD': '/builds/slave/test', 21:59:48 INFO - 'SHELL': '/bin/bash', 21:59:48 INFO - 'SHLVL': '1', 21:59:48 INFO - 'TERM': 'linux', 21:59:48 INFO - 'TMOUT': '86400', 21:59:48 INFO - 'USER': 'cltbld', 21:59:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 21:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:48 INFO - '_': '/tools/buildbot/bin/python'} 21:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:48 INFO - Downloading/unpacking blobuploader==1.2.4 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:50 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:59:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:51 INFO - Downloading docopt-0.6.1.tar.gz 21:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:51 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:51 INFO - Running setup.py install for blobuploader 21:59:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:59:51 INFO - Running setup.py install for requests 21:59:51 INFO - Running setup.py install for docopt 21:59:51 INFO - Successfully installed blobuploader requests docopt 21:59:51 INFO - Cleaning up... 21:59:51 INFO - Return code: 0 21:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', '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 21:59: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 21:59: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 21:59:51 INFO - Using env: {'DISPLAY': ':0', 21:59:51 INFO - 'HOME': '/home/cltbld', 21:59:51 INFO - 'LANG': 'en_US.UTF-8', 21:59:51 INFO - 'LANGUAGE': 'en_US:en', 21:59:51 INFO - 'LOGNAME': 'cltbld', 21:59:51 INFO - 'MAIL': '/var/mail/cltbld', 21:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:51 INFO - 'MOZ_NO_REMOTE': '1', 21:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:51 INFO - 'NO_EM_RESTART': '1', 21:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:51 INFO - 'PWD': '/builds/slave/test', 21:59:51 INFO - 'SHELL': '/bin/bash', 21:59:51 INFO - 'SHLVL': '1', 21:59:51 INFO - 'TERM': 'linux', 21:59:51 INFO - 'TMOUT': '86400', 21:59:51 INFO - 'USER': 'cltbld', 21:59:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 21:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:51 INFO - '_': '/tools/buildbot/bin/python'} 21:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:52 INFO - Running setup.py (path:/tmp/pip-CIt_6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:52 INFO - Running setup.py (path:/tmp/pip-qedbIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:52 INFO - Running setup.py (path:/tmp/pip-dvjBWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:52 INFO - Running setup.py (path:/tmp/pip-jEdEND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:52 INFO - Running setup.py (path:/tmp/pip-ANJID7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:52 INFO - Running setup.py (path:/tmp/pip-wWjSFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:52 INFO - Running setup.py (path:/tmp/pip-IlFfSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:52 INFO - Running setup.py (path:/tmp/pip-EJvAp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:52 INFO - Running setup.py (path:/tmp/pip-9Pc58i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:52 INFO - Running setup.py (path:/tmp/pip-Gjs6Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:52 INFO - Running setup.py (path:/tmp/pip-fVW_S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:52 INFO - Running setup.py (path:/tmp/pip-L2EG0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:52 INFO - Running setup.py (path:/tmp/pip-pNNkbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:53 INFO - Running setup.py (path:/tmp/pip-Wht7m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:53 INFO - Running setup.py (path:/tmp/pip-ubjGxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:53 INFO - Running setup.py (path:/tmp/pip-qTxtou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:53 INFO - Running setup.py (path:/tmp/pip-pAVBvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:53 INFO - Running setup.py install for manifestparser 21:59:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:59:53 INFO - Running setup.py install for mozcrash 21:59:53 INFO - Running setup.py install for mozdebug 21:59:53 INFO - Running setup.py install for mozdevice 21:59:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:59:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:59:53 INFO - Running setup.py install for mozfile 21:59:53 INFO - Running setup.py install for mozhttpd 21:59:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:59:53 INFO - Running setup.py install for mozinfo 21:59:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Running setup.py install for mozInstall 21:59:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Running setup.py install for mozleak 21:59:54 INFO - Running setup.py install for mozlog 21:59:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Running setup.py install for moznetwork 21:59:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Running setup.py install for mozprocess 21:59:54 INFO - Running setup.py install for mozprofile 21:59:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Running setup.py install for mozrunner 21:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:59:54 INFO - Running setup.py install for mozscreenshot 21:59:54 INFO - Running setup.py install for moztest 21:59:55 INFO - Running setup.py install for mozversion 21:59:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:59:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:55 INFO - Cleaning up... 21:59:55 INFO - Return code: 0 21:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', '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 21:59: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 21:59: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 21:59:55 INFO - Using env: {'DISPLAY': ':0', 21:59:55 INFO - 'HOME': '/home/cltbld', 21:59:55 INFO - 'LANG': 'en_US.UTF-8', 21:59:55 INFO - 'LANGUAGE': 'en_US:en', 21:59:55 INFO - 'LOGNAME': 'cltbld', 21:59:55 INFO - 'MAIL': '/var/mail/cltbld', 21:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:55 INFO - 'MOZ_NO_REMOTE': '1', 21:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:55 INFO - 'NO_EM_RESTART': '1', 21:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:55 INFO - 'PWD': '/builds/slave/test', 21:59:55 INFO - 'SHELL': '/bin/bash', 21:59:55 INFO - 'SHLVL': '1', 21:59:55 INFO - 'TERM': 'linux', 21:59:55 INFO - 'TMOUT': '86400', 21:59:55 INFO - 'USER': 'cltbld', 21:59:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 21:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:55 INFO - '_': '/tools/buildbot/bin/python'} 21:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:55 INFO - Running setup.py (path:/tmp/pip-O7QLka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:55 INFO - Running setup.py (path:/tmp/pip-YLp4Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:55 INFO - Running setup.py (path:/tmp/pip-hMp6ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:55 INFO - Running setup.py (path:/tmp/pip-4YzQgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:55 INFO - Running setup.py (path:/tmp/pip-EAVpJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:55 INFO - Running setup.py (path:/tmp/pip-89o3Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:55 INFO - Running setup.py (path:/tmp/pip-kV9His-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:55 INFO - Running setup.py (path:/tmp/pip-aKD9Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:55 INFO - Running setup.py (path:/tmp/pip-Dn2Rmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59: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)) 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:56 INFO - Running setup.py (path:/tmp/pip-lkYxsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:56 INFO - Running setup.py (path:/tmp/pip-AQyXN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59: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)) 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:56 INFO - Running setup.py (path:/tmp/pip-Hc5BQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59: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)) 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:56 INFO - Running setup.py (path:/tmp/pip-yvFZWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59: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)) 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:56 INFO - Running setup.py (path:/tmp/pip-ewT0Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59: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)) 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:56 INFO - Running setup.py (path:/tmp/pip-Vo3ra_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59: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)) 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:56 INFO - Running setup.py (path:/tmp/pip-hjJy8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59: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)) 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:56 INFO - Running setup.py (path:/tmp/pip-GqEYlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59:58 INFO - Downloading blessings-1.6.tar.gz 21:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:58 INFO - Installing collected packages: blessings 21:59:58 INFO - Running setup.py install for blessings 21:59:58 INFO - Successfully installed blessings 21:59:58 INFO - Cleaning up... 21:59:58 INFO - Return code: 0 21:59:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:58 INFO - Reading from file tmpfile_stdout 21:59:58 INFO - Current package versions: 21:59:58 INFO - argparse == 1.2.1 21:59:58 INFO - blessings == 1.6 21:59:58 INFO - blobuploader == 1.2.4 21:59:58 INFO - docopt == 0.6.1 21:59:58 INFO - manifestparser == 1.1 21:59:58 INFO - mozInstall == 1.12 21:59:58 INFO - mozcrash == 0.17 21:59:58 INFO - mozdebug == 0.1 21:59:58 INFO - mozdevice == 0.48 21:59:58 INFO - mozfile == 1.2 21:59:58 INFO - mozhttpd == 0.7 21:59:58 INFO - mozinfo == 0.9 21:59:58 INFO - mozleak == 0.1 21:59:58 INFO - mozlog == 3.1 21:59:58 INFO - moznetwork == 0.27 21:59:58 INFO - mozprocess == 0.22 21:59:58 INFO - mozprofile == 0.28 21:59:58 INFO - mozrunner == 6.11 21:59:58 INFO - mozscreenshot == 0.1 21:59:58 INFO - mozsystemmonitor == 0.0 21:59:58 INFO - moztest == 0.7 21:59:58 INFO - mozversion == 1.4 21:59:58 INFO - psutil == 3.1.1 21:59:58 INFO - requests == 1.2.3 21:59:58 INFO - wsgiref == 0.1.2 21:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', '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 21:59: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 21:59: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 21:59:58 INFO - Using env: {'DISPLAY': ':0', 21:59:58 INFO - 'HOME': '/home/cltbld', 21:59:58 INFO - 'LANG': 'en_US.UTF-8', 21:59:58 INFO - 'LANGUAGE': 'en_US:en', 21:59:58 INFO - 'LOGNAME': 'cltbld', 21:59:58 INFO - 'MAIL': '/var/mail/cltbld', 21:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:58 INFO - 'MOZ_NO_REMOTE': '1', 21:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:58 INFO - 'NO_EM_RESTART': '1', 21:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:58 INFO - 'PWD': '/builds/slave/test', 21:59:58 INFO - 'SHELL': '/bin/bash', 21:59:58 INFO - 'SHLVL': '1', 21:59:58 INFO - 'TERM': 'linux', 21:59:58 INFO - 'TMOUT': '86400', 21:59:58 INFO - 'USER': 'cltbld', 21:59:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 21:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:58 INFO - '_': '/tools/buildbot/bin/python'} 21:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59: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)) 21:59:59 INFO - Cleaning up... 21:59:59 INFO - Return code: 0 21:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', '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 21:59: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 21:59: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 21:59:59 INFO - Using env: {'DISPLAY': ':0', 21:59:59 INFO - 'HOME': '/home/cltbld', 21:59:59 INFO - 'LANG': 'en_US.UTF-8', 21:59:59 INFO - 'LANGUAGE': 'en_US:en', 21:59:59 INFO - 'LOGNAME': 'cltbld', 21:59:59 INFO - 'MAIL': '/var/mail/cltbld', 21:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:59 INFO - 'MOZ_NO_REMOTE': '1', 21:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:59 INFO - 'NO_EM_RESTART': '1', 21:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:59 INFO - 'PWD': '/builds/slave/test', 21:59:59 INFO - 'SHELL': '/bin/bash', 21:59:59 INFO - 'SHLVL': '1', 21:59:59 INFO - 'TERM': 'linux', 21:59:59 INFO - 'TMOUT': '86400', 21:59:59 INFO - 'USER': 'cltbld', 21:59:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 21:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:59 INFO - '_': '/tools/buildbot/bin/python'} 21:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:59 INFO - Downloading/unpacking jsonschema 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 21:59: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 22:00:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:01 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:01 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:01 INFO - warning: no files found matching '*.txt' 22:00:01 INFO - no previously-included directories found matching 'build' 22:00:01 INFO - no previously-included directories found matching 'dist' 22:00:01 INFO - no previously-included directories found matching '.git*' 22:00:01 INFO - Installing collected packages: jsonschema, functools32 22:00:01 INFO - Running setup.py install for functools32 22:00:01 INFO - warning: no files found matching '*.txt' 22:00:01 INFO - no previously-included directories found matching 'build' 22:00:01 INFO - no previously-included directories found matching 'dist' 22:00:01 INFO - no previously-included directories found matching '.git*' 22:00:01 INFO - Successfully installed jsonschema functools32 22:00:01 INFO - Cleaning up... 22:00:01 INFO - Return code: 0 22:00:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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 0x7f35e5c20f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00: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 22:00: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 22:00:01 INFO - Using env: {'DISPLAY': ':0', 22:00:01 INFO - 'HOME': '/home/cltbld', 22:00:01 INFO - 'LANG': 'en_US.UTF-8', 22:00:01 INFO - 'LANGUAGE': 'en_US:en', 22:00:01 INFO - 'LOGNAME': 'cltbld', 22:00:01 INFO - 'MAIL': '/var/mail/cltbld', 22:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:01 INFO - 'MOZ_NO_REMOTE': '1', 22:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:01 INFO - 'NO_EM_RESTART': '1', 22:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:01 INFO - 'PWD': '/builds/slave/test', 22:00:01 INFO - 'SHELL': '/bin/bash', 22:00:01 INFO - 'SHLVL': '1', 22:00:01 INFO - 'TERM': 'linux', 22:00:01 INFO - 'TMOUT': '86400', 22:00:01 INFO - 'USER': 'cltbld', 22:00:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 22:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:01 INFO - '_': '/tools/buildbot/bin/python'} 22:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:01 INFO - Downloading/unpacking flake8 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:04 INFO - no previously-included directories found matching 'docs/_build' 22:00:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:04 INFO - Running setup.py install for pep8 22:00:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:04 INFO - no previously-included directories found matching 'docs/_build' 22:00:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:00:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:04 INFO - Cleaning up... 22:00:04 INFO - Return code: 0 22:00:04 INFO - Running post-action listener: _resource_record_post_action 22:00:04 INFO - Running post-action listener: _start_resource_monitoring 22:00:04 INFO - Starting resource monitoring. 22:00:04 INFO - ##### 22:00:04 INFO - ##### Running install step. 22:00:04 INFO - ##### 22:00:04 INFO - Running pre-action listener: _resource_record_pre_action 22:00:04 INFO - Running main action method: install 22:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:04 INFO - Reading from file tmpfile_stdout 22:00:04 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:00:05 INFO - Reading from file tmpfile_stdout 22:00:05 INFO - Output received: 22:00:05 INFO - Usage: mozinstall [options] installer 22:00:05 INFO - Options: 22:00:05 INFO - -h, --help show this help message and exit 22:00:05 INFO - -d DEST, --destination=DEST 22:00:05 INFO - Directory to install application into. [default: 22:00:05 INFO - "/builds/slave/test"] 22:00:05 INFO - --app=APP Application being installed. [default: firefox] 22:00:05 INFO - mkdir: /builds/slave/test/build/application 22:00:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:00:20 INFO - Reading from file tmpfile_stdout 22:00:20 INFO - Output received: 22:00:20 INFO - /builds/slave/test/build/application/firefox/firefox 22:00:20 INFO - Running post-action listener: _resource_record_post_action 22:00:20 INFO - ##### 22:00:20 INFO - ##### Running run-tests step. 22:00:20 INFO - ##### 22:00:20 INFO - Running pre-action listener: _resource_record_pre_action 22:00:20 INFO - Running main action method: run_tests 22:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:20 INFO - Python 2.7.3 22:00:20 INFO - Return code: 0 22:00:20 INFO - grabbing minidump binary from tooltool 22:00: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')]} 22:00: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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d3f410>, '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 0x2d40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d407a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00: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 22:00: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 22:00:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:20 INFO - Return code: 0 22:00:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:00:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:00:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:00:21 INFO - Return code: 0 22:00: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/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 22:00: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/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 22:00:21 INFO - Using env: {'DISPLAY': ':0', 22:00:21 INFO - 'HOME': '/home/cltbld', 22:00:21 INFO - 'LANG': 'en_US.UTF-8', 22:00:21 INFO - 'LANGUAGE': 'en_US:en', 22:00:21 INFO - 'LOGNAME': 'cltbld', 22:00:21 INFO - 'MAIL': '/var/mail/cltbld', 22:00:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:21 INFO - 'MOZ_NO_REMOTE': '1', 22:00:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:21 INFO - 'NO_EM_RESTART': '1', 22:00:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:21 INFO - 'PWD': '/builds/slave/test', 22:00:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:21 INFO - 'SHELL': '/bin/bash', 22:00:21 INFO - 'SHLVL': '1', 22:00:21 INFO - 'TERM': 'linux', 22:00:21 INFO - 'TMOUT': '86400', 22:00:21 INFO - 'USER': 'cltbld', 22:00:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832', 22:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:21 INFO - '_': '/tools/buildbot/bin/python'} 22:00: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/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 22:00:21 INFO - mozversion application_buildid: 20160406211248 22:00:21 INFO - mozversion application_changeset: 8fc46323cee61bddc4c38701d6020379bba5774a 22:00:21 INFO - mozversion application_display_name: Nightly 22:00:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:21 INFO - mozversion application_name: Firefox 22:00:21 INFO - mozversion application_remotingname: firefox 22:00:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:00:21 INFO - mozversion application_vendor: Mozilla 22:00:21 INFO - mozversion application_version: 48.0a1 22:00:21 INFO - mozversion platform_buildid: 20160406211248 22:00:21 INFO - mozversion platform_changeset: 8fc46323cee61bddc4c38701d6020379bba5774a 22:00:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:00:21 INFO - mozversion platform_version: 48.0a1 22:00:21 INFO - using testdate: 1460005221 22:00:21 INFO - actual date: 1460005221 22:00:21 INFO - starting webserver on 'localhost:32870' 22:00:21 INFO - SUITE-START | Running 2 tests 22:00:21 INFO - TEST-START | dromaeo_css 22:00:21 INFO - operating with platform_type : linux_ 22:00:21 INFO - Initialising browser for dromaeo_css test... 22:00:21 INFO - TEST-INFO | started process 25130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLYA3fK/profile http://localhost:32870/getInfo.html) 22:00:26 INFO - PROCESS | 25130 | __metrics Screen width/height:1600/1200 22:00:26 INFO - PROCESS | 25130 | colorDepth:24 22:00:26 INFO - PROCESS | 25130 | Browser inner width/height: 1024/697 22:00:26 INFO - PROCESS | 25130 | __metrics 22:00:27 ERROR - PROCESS | 25130 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:00:28 INFO - TEST-INFO | 25130: exit 0 22:00:28 INFO - Browser initialized. 22:00:28 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:28 INFO - TEST-INFO | started process 25211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLYA3fK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:40 INFO - PROCESS | 25211 | RSS: Main: 154099712 22:00:40 INFO - PROCESS | 25211 | 22:01:31 INFO - PROCESS | 25211 | 1460005291116 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:03:42 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:32870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32870/tests/dromaeo/cssquery-ext.html) 22:03:43 INFO - PROCESS | 25211 | RSS: Main: 265834496 22:03:43 INFO - PROCESS | 25211 | 22:06:46 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:32870/tests/dromaeo/cssquery-ext.html (next: http://localhost:32870/tests/dromaeo/cssquery-jquery.html) 22:06:46 INFO - PROCESS | 25211 | RSS: Main: 236609536 22:06:46 INFO - PROCESS | 25211 | 22:09:48 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:32870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32870/tests/dromaeo/cssquery-mootools.html) 22:09:49 INFO - PROCESS | 25211 | RSS: Main: 241053696 22:09:49 INFO - PROCESS | 25211 | 22:12:51 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:32870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32870/tests/dromaeo/cssquery-prototype.html) 22:12:51 INFO - PROCESS | 25211 | RSS: Main: 217587712 22:12:51 INFO - PROCESS | 25211 | 22:15:54 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:32870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32870/tests/dromaeo/cssquery-yui.html) 22:15:55 INFO - PROCESS | 25211 | RSS: Main: 200704000 22:15:55 INFO - PROCESS | 25211 | 22:18:57 INFO - PROCESS | 25211 | Cycle 1(1): loaded http://localhost:32870/tests/dromaeo/cssquery-yui.html (next: http://localhost:32870/tests/dromaeo/cssquery-dojo.html) 22:18:58 INFO - PROCESS | 25211 | RSS: Main: 248860672 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - PROCESS | 25211 | __start_tp_report 22:18:58 INFO - PROCESS | 25211 | _x_x_mozilla_page_load 22:18:58 INFO - PROCESS | 25211 | _x_x_mozilla_page_load_details 22:18:58 INFO - PROCESS | 25211 | |i|pagename|runs| 22:18:58 INFO - PROCESS | 25211 | |0;dojo.html;2599.3631560267736;2661.055325359497;2670.3146374829003;2679.9866000669995;2713.7421944915227;4569.497355290923;4659.580637742602;4667.136579732752;4679.906401871961;4684.039771846772;4570.817167313312;4579.152856721509;4689.155951928651;4712.599429048535;4714.717116972984;4241.787910604473;4282.914341713172;4299.269124248885;4352.869413917588;4432.445944256968;4348;4378.759168245745;4395.384646149541;4406;4409.603135717784;4196.139791342767;4284.250256205151;4320.891977700567;4330.523642399334;4405.845795397146;4300.462442194726;4314.072474418015;4349.238883195429;4351.934720979188;4374.693771436001;4279.358096285551;4289.871303860889;4303.139372125587;4316.201502722007;4331.956680433187;4486.9326960095295;4501.414816073922;4531.592156705912;4570.382998295221;4610.216263235258;4998.550130488274;5011;5015.072211640858;5027.648064635477;5058.696478211319;5027.949720502821;5044.848654540333;5048;5051;5084.542391184774;4611.654125940568;4655.441347038377;4694.24892017279;4700.929486057677;4735.2186889163595;5208.348956380452;5208.9739551302;5215.765290561933;5233.4243233244315;5245.816396426107;4988.925166122439;4992.675476094042;4997.90004199914;4998.450170481244;5045.41977672565;4906.950930490721;4959.7272150032095;5004.349434573555;5061.089003979319;5071.594272458195;4919.827806026772;4928.778204980785;4939.234418665113;4945.802167913315;4997.325361076281;4915.827946021872;4925.630577706686;4926.433460152057;4927.728974906415;4972.825951091694;4147.834086636501;4213.2837417639075;4222.3244280914905;4279.33670281107;4293.699441039097;3712.777233366007;3740.2706472238197;3747.6065013173225;3750.268697603941;3760.7743535387963;4344.978275108604;4346.6522678185665;4350.58669426404;4359.934600980988;4388.934165987513;4941.407031156213;5011.047900898818;5016.949830501649;5105.5149760772665;5113.233015047773;4328.177646247203;4334.891627709332;4335.34969754533;4337.067530480962;4378.846740364072;4508.864734057918;4512.548745125527;4520.321951707205;4521.864344069683;4527.47933987589;4559.361689363492;4759.1671457495495;4799.304100905419;4810.206315957827;4846.200376937766;5013.724245166551;5017.12200364942;5034.572061374678;5041.798328066836;5079.187330027178;4630.467496237976;4743.620510359094;4758.048390322018;4760.738159401266;4795.160846851717;4944.3572335596145;4980.277859710394;4988.600911927109;5014.824481143142;5027.371578552681;5017.57350625201;5055.34280543527;5056.84829455117;5057.570106540985;5108.923366149436;4700.529947005272;4824.372831531879;4906.779194936165;4919.065377578248;4964.478729733326;4833.613310935047;4854.344663470528;4865.440474345495;4869.732164730974;4905.9018819624125;4772.6659133861685;4782.736949467812;4797.352357431702;4801.927971080507;4827.203511420576;4764.2615394613895;4855.6601037927;4900.534449227318;4908.631852610997;4926.064047830901;4779.545943135397;4780.976095119502;4801.4718380977365;4815.3499277597075;4845.563899249085 22:18:58 INFO - PROCESS | 25211 | |1;ext.html;537.6156048425376;541.5315751874629;556.1296570866596;560.3080195957992;576.0610205365253;27476.587851182223;34627.4805877912;35428;35438.82280588593;35464.290714185736;38686.613133868654;39127.21745565094;39152.80423597878;39163.41254881179;39182.21635567287;7533.736319228814;7701.152873183945;7715.845683086335;7719.691212351499;7724.652390642406;7605.391568674493;7727.536347819121;7732.188120247378;7734.729284475045;7876.881846772274;7819.687212511492;7876;7884;7889.644965976516;7897.052353717533;7796.337311328515;7858.449908506407;7868.25251601097;7868.567228802413;7871.960640196791;7681.270279323456;7795.33739632132;7797.298243158143;7802.765917022499;7807.6096195190585;38560.61439385598;39081.80459097686;39095.41356879649;39120.21759564821;39157;3077.861496232675;3214.9839250803598;3218.5494030835703;3501.859925602973;3736.196717705679;28839.56740648871;28880.71119288801;29273.268168295752;29659.55510667342;29819.552706709415;3322.435186018383;3432.390571384448;3443.7589368743947;3447.1554469154967;3486.0064881508647;234601;236520;236532;237347;237782;53382.73308633432;53522;53677.463225367246;53767;53777.1933420999;55557.44442555604;56728.432715672316;56836.715816420656;58311;59059.161154524816;12667.429965651569;12742.235465871892;12814.487420503261;12879.098463107492;12879.871201288055;10210.897891021143;10213.642522511676;10217.795644087077;10226.795464090825;10269.794604107876;16475.917620411823;16895.493135205965;18824.717629235573;18933;19147.425577232705;6922.965385173042;7028.929710702828;7075.893861592081;7158.176809666851;7267.273272672691;884.7611144990816;936.5317341329335;941.7268991992382;1017.3438132404558;1036.108946306176;25807.225783226535;27175.1847444577;27298.45403091927;27462.45075098487;27565.17304480869;997.9002099789963;1024.6721049264313;1037.4708898461838;1064.4518073192312;1068.0014186735427;13884.722305553832;14277.14337139775;14551.27243637835;14588.34352454142;14595.372832890182;276205;281304;281641;281853;282746;43860;45743.77128114338;45802;45875.77062114735;45882.54117458849;1093.5188517052472;1244.147758785235;1262.6969527313563;1277.067740549404;1325.5691900132495;26365.4726905457;27314.180574582795;27356.863215683796;28081.297967550974;28171.43657126887;37758.81120594379;38292.234155317296;38367.42448863213;38431.61568384281;38446.615533844306;193486;197686;198352;198465;198850;27386.72613273842;29742;31034;31637.8418107908;31669;36912.81543592265;37938.051548711504;38046;38177.618223818514;38419.615803842724;33232.66767332392;34423;34681.1329716749;35130.29739405249;35440.822795885855;33814.49278260779;34123.829380852934;34336;34382.65617343794;34745.30509389849;33858.32283354369;34284;34419;34434;34843;30210.84894575513;31221.37557248797;31667.683323166475;31690.524642130847;31721.8413907929;24107.27678169658;24449.755502444747;24459.51080978406;24677.753222468265;24796.50406991886 22:18:58 INFO - PROCESS | 25211 | |2;jquery.html;340.4093897088551;342.8268724294232;344.80690813144656;344.8344794498639;349.57177457614426;14654.267286635652;15203.239838008098;15812;16400.097994610293;16438;15475.14886681232;15764.921175394107;16070.99999999997;16170.676586468293;16176.676466470664;4767.261074533453;4920.901581968358;4925.408950925876;4937.580305674022;4958.107540642683;4973.751312434382;5158.664686795346;5165.664231824938;5188.7146206958605;5192.376914770233;5126.897462050757;5169.431362550116;5173.068847607429;5176.145935920568;5179.4561571035065;4967.155583550787;5153.484651534854;5174.2238664200295;5179.19722443022;5179.585633149339;4954.157793175169;4977.626677999165;4980.526849949285;4996.825111121129;5005.2492126181;11381.374024428653;16255.756163657554;17942.461726148238;17977.280908763634;17985.190666420043;1908.1794828223858;1973.9111739971593;1995.1420889017716;2012.7584689837167;2020.929267475646;8715.869261961076;8820.779480512974;9085.454872707593;9207.677731279373;11788;1726.8273172682757;1761.867859910499;1775.3697437409662;1794.2912549542857;1809.4390738870993;54315.728421358035;59576;59730;60076.699616502076;60147.39852601506;9209.355345125778;9283.72148835536;9323.953380233055;9519.762005949906;9540.475273860004;12712.872871271355;12868;12894;12910.9354453229;12913.935430322788;7029.22678505364;7161.89257161143;7171.354578087997;7289.890651640229;7332.486725929134;6985.93014069863;7072.71709131629;7081.114860642419;7098.751543695946;7120.679569419389;4135.710500265012;4149.937750933738;4159.771212583277;4203.495580530356;4204.138151678899;1697.4483292929847;1749.553863764732;1750.8336708012719;1767.4962635649035;1770.6724256012678;826.8842362069315;879.445949052093;917.898521773874;936.3960245641523;939.9342046056711;14385.64035899111;15070;15318.617034574001;15525.844741552666;15566.377344906303;843.1231519220065;850.5279569838675;882.7219425880827;888.7555922121468;910.4855756497558;8562.186592273723;8649.394542381973;8723;8986.281097512183;8987.775305617412;376075;380569;385698;389752;397510;51121.233181502306;63883;66054.66972665202;66920.33079669239;68583.65708171428;898.9460632362079;921.870938068671;934.9298802589697;940.1256831147099;942.1050002497655;13640.181589104686;14048.508302209782;14147;14256.786148207993;14311.856881431053;31315.84342078275;32216.19459513531;32648;32831;32927.83536082304;43220.351694725236;44775;44956.77521612502;45421.77289113666;45488.77255613701;6824.863502730017;6897.7585784497305;6981.441484681111;7004.649767511706;7070.964645176947;10055.346402483816;10408.895911040792;10410.635627752992;10445.529951152368;10530.104941080093;8423.157684231774;9030.503322317072;9045.819083618158;9298.860517092384;9401.918779340464;8835.823283534164;8961.955190224007;8970;9242.399244049115;9255.629774809202;9089.590968406304;9215.078492150731;9346.859797102912;9375.203107735919;9472.95263523678;6680.732770689118;6732.865342693217;6787.287334829772;6825.52221344521;6938.757143499954;9087.59105840252;9188.173064424234;9391.906080939103;9431;9507.952460237655 22:18:58 INFO - PROCESS | 25211 | |3;mootools.html;1317.446672397593;1402.894782891283;1423.8077859488965;1549.9612509687256;1761.471558532439;6701.59790412575;7387.26127387261;7547.962260188691;7548.320651141396;7551.92448075519;7339.59632220229;7516.060492438445;7524.924750752491;7535.886961695579;7538.924610753891;1862.9627407451842;1914.1003728247701;2225.2656623314347;2230.074519074586;2261.807746341563;2189.6824960380736;2201.3175915466177;2203.537257175995;2204.4709269775217;2204.911803527857;2219;2241.7085778848727;2280.2133264023887;2282.3038973113194;2282.315305408379;2193.2214064007208;2226.1318085946496;2237.8209743220505;2238.0488292475716;2243.293362590795;2186.8469207155504;2193.243331050785;2215.9778402215934;2216.34617787753;2218.024069409471;7738.961305193494;7797.298243158086;7803.8439231215625;7808.5314881107315;7815.218478152139;4538.205813982539;4603.401557797499;4638.095571363586;4639.5824375806005;4640.67515273931;2879.4097210071886;2909.796314258003;2915.8833646654107;2917.6644685861183;3062.617172853393;977.8679878216492;980.9068138526828;992.4343124419084;992.8163289791412;1002.8846682631518;10259.794804103876;10320.79358412835;10382.325148865375;10394.532246048946;10412.219083568763;4095.1604920991126;4245.087306229176;4286.721363111388;4311.094670119247;4311.719738217006;8839.46963182211;8872.8669069964;8885.733427997042;8910.420822646507;8914.153155450222;4592.494825569184;4605.355250264965;4618.284165954283;4620.445546534437;4627.838025669153;3778.282126396031;4089.6114869087387;4213.894652633709;4240.766757828287;4247.787610619518;3616.5840928293583;3669.43123815809;3687.815609219528;3699.8335074921692;3770.7360484765804;1205.6925484001524;1211.612284069107;1218.3481837217046;1220.798568236249;1222.9205101668363;972.8492083727034;984.2814745236018;991.1723710701501;1040.3913710479455;1199.322382853685;7218.314260145278;7247.4926755126635;7257.129144502694;7289;7291.708331666674;456.83734894693083;458.3903408466731;459.59785187960534;460.24979283767243;461.3264633634931;5464.754086066137;5503.834884953458;5508.834734957958;5516.3380394352935;5558.77764889408;9424.151826335663;9735.318527702993;9754.268429867789;9769.51152442375;9781.755456113511;9190.172884440433;9543.47510886894;9545.761355966157;9592.904070959341;9607.807843843084;7326.633668316563;7335.963320183365;7416.814579635445;7449.180590135081;7484.101907771103;6897.7240910363025;6990.475714321548;6994.510384273256;6997.720091196499;7001.754938577125;8374.07885132647;8375.95812020936;8531.957340213508;8550.91449085526;8632.352573556882;8609.65561377538;8663.826723465621;8664.610092545725;8753.431026983226;8825.779355516164;5685.77256909719;6308.495320374451;6462.3537646235;6651.63416012124;6722.697478613376;7158.105236845395;7159.856802863809;7197.532160409557;7214.71141154348;7242.058532390755;6310.400511951358;6723.630200339028;6724.327567243236;6810.8637827244165;6842.8289292766085;6654.467642588678;6665.700043498151;6689.632070236184;6707.429868461236;6724.193096828412;6852.109225800614;6891.138607674041;6961.060256865461;6961.686724097529;6965.79102626922;6300.495960323255;6362.204724409449;6366.236051673829;6369.33122022181;6380.7447702091395;6324.367563243639;6382.234131904202;6384.3934826191435;6386.840328991812;6400.743970241138 22:18:58 INFO - PROCESS | 25211 | |4;prototype.html;309.4013084681142;309.7986308899216;316.9160172554273;321.4663658327176;322.65959412819495;5224.63427560071;5304.018756530045;5318.175682769167;5330.653507522008;5357.8392648220515;5243.632945693803;5258.474152584749;5260.132078207101;5287.973560132194;5291.761870715817;3944.073142811437;4006.659433948118;4084.9387259191135;4103.712740108193;4115.485564304462;4092.529359123694;4098.241825262321;4106.8767936961785;4111.095558977036;4112.897177570555;4056.5132184137947;4060.4112403701447;4068.125353049094;4068.776217308047;4069.125138095309;3927.293087244295;4010.8997275068064;4098.139390727951;4102.938455923164;4103.958960410388;3612.9277414451826;3613.2231570212266;3615.963840361589;3618.8914332570066;3625.274945010982;5093.0577843099145;5099.235114732783;5104.974475127638;5105.923411148836;5111.182210846284;4720.905581888343;4722.3152642866935;4725.905481890377;4732.455767586737;4736.739479328636;5538.833834984957;5541.639793413456;5542.86142846428;5543.307086614173;5550.58370622205;3951.269015232191;3959.5644479107277;3968.761874287523;3975.7415767975276;3976.443297938291;5585.469380408855;5838.2702162229725;5847.8538036549;5852.590318677694;5861.267341582345;3893.396523538856;3930.8231129599235;3934.449177115206;3936.9212615747524;3945.309570825094;3990.980045099756;3992.001999500125;3996.1208534122447;3996.580359062257;3998.3202855514633;4604.884877878013;4611.76941152941;4613.354130421743;4619.584237418581;4624.653151013687;5562.833115006556;5565.415631358649;5573.247611572467;5573.303337082864;5574.749136288877;1393.5401317565381;1418.4751641892565;1419.865112814281;1420.552525954321;1421.5380001499555;882.5631312500353;908.2370808520874;922.5479515037583;925.8564922437033;949.4398305000083;4860.343853579721;4865.0756356292195;4886.82896098642;4894.290327902434;4896.167651499253;5695.715214239354;5698.6580805151825;5699.316082070178;5700.173474846207;5702.116171993348;4870.732109733999;4882.048000639841;4882.096812089775;4884.169691152512;4890.315355850184;3028.651705053903;3057.2968217310145;3063.433264846011;3073.047355319858;3075.8923437680023;5379.919301210485;5386.138217885198;5390.730463476811;5392.40683524812;5396.4333744957;5746.252987111732;5850.151727999416;5955.136505206808;5972.46247837688;5983.970080149571;5478;5492.890142197134;5497.39528651856;5497.532709719639;5513.641613295123;5829.854253643523;5834.212381328636;5836.153757705024;5840.766369345179;5843.386444423274;5672.12082127271;5684.0621297487105;5685.459881311269;5693.060644993529;5695.800646977336;5486.1222204447095;5491.231227628055;5494.642848214853;5502.697351645698;5504.972475137599;3808.8095595219575;3902.414637804352;3926.9607303926596;3931.5871833457077;3935.685145188321;5607.383187849415;5638.23883775685;5645.068563686946;5650.745716442688;5659.6321239119325;5473.945260547503;5474.233607294902;5539.086050801734;5575.609707320611;5583.35791383996;5562;5564.081926482085;5573.108302671553;5574.303212098488;5587.497125258747;5489.917651235155;5493;5500.532454741392;5501.477359650827;5503.724813759216;5451.100568406168;5587.161925711176;5604.103343465026;5604.299462567179;5613.410591887956;5432.59255555827;5461.5357694596405;5464.890702186013;5473.151661492475;5486.588505861996 22:18:58 INFO - PROCESS | 25211 | |5;yui.html;675.6959368284273;677.5663575311798;704.8132244955087;733.5048842031629;755.6108604068905;11342.092632589394;11386.430678466075;11434.771304573904;11439.485223164957;11594.826077608843;11576.47905844237;11705.882941170586;11770.823437648422;11848.348340841272;11864.644060678173;646.5991085526956;660.6762686283711;804.593680191504;819.4223072733708;819.737683941139;787.629813987425;816.9183081691842;816.9468984515987;817.2726273616486;817.8732296494023;837.6356285016037;847.4068152293388;848.2196379331031;849.1975083546051;849.9235068843802;669.7823207457595;804.1516200408566;839.3495041342946;845.8604330285496;852.8209076094028;618.6844709198341;620.4694985787132;621.0745988477137;621.4313902778952;623.3672822085587;11158.66524004273;11197.272177308449;11203.551857925673;11206.327620342723;11216.943915280453;11399.829002564968;12476.937615311865;12514.561990330385;12654.683632909158;12748.745025099539;10131.341462804969;10173.89826101737;10232.488375581192;10245.180385569136;10280.12618927392;3245.821479818609;3274.3942370661503;3287.3589650018257;3335.34960682667;3385.153711572107;41793.373099403536;41921.580784192374;42033.789831050955;42121;42298;9991.900080999098;10029.548670309854;10032.097111260022;10199.490025498695;10211.234157438223;17622.911885440746;17830.19764110618;17851.553711157325;17989.190486428142;18041.458756237334;6859.5541289816;6949.617771022541;6975.058367120475;7001.404880585105;7028.437724982092;3681.447782832543;3707.5180226570374;3722.994791406305;3753.7425707178463;3761.39817629178;2776.6390369251867;2786.7909906757072;2802.285417218637;2807.284142543638;2809.0870467098275;485.52418629742346;488.7043338780058;495.2793685188043;506.6301599832143;548.3009163316723;583.3787016827066;583.4661284924332;589.0780927847904;589.2222266608036;589.4282545930527;8136.796580085427;8347.4156809024;8464.349451856951;8544.48733076005;8665.566721663892;560.9579281553899;595.0093094996869;611.6849822341497;616.6639181646013;623.76297007137;3691.187938653492;3756.9436458453147;3927.587603301612;3937.625925537069;4033.757974521538;48372.27441588379;48463.75768121137;49402.75298623556;49458.25812612814;49586.50413495891;42901;43484;43738.34392484115;44002.55997440049;45345.77327113343;38740.41889371662;39630.207395851925;40594.391084133764;40677.389839152434;40834.18331633351;7407.777766667009;7657.961710191414;7665.6550455228535;7750.728724494616;7850.685972561262;30922.845385772926;31429;32013.199670007503;32016.67983320137;32019.839900800347;37083.814580926926;38405.423918640685;40054.79972600118;40249.798751006056;40315;9446.669366572138;9451.196648284973;9546.188573971012;9581.808363832824;9641;10235.232357573062;10241.231907607109;10344.586216551254;10447.843282350923;10627.309224900357;8457.619407126816;10550;10607.946960265457;10613.893861061291;10756.784864302514;10369;10417.687469375931;10482.842757358798;10511.159107271553;10877.51051202682;10176.949115254376;10514.631987880388;10965.232433729563;11017.83473247918;11123.27698699582;9159.129882661136;9312.301577381588;9331.673391431268;9417.905820941703;9494.620215191315;8790.912090879265;8957;9222.907770922206;9266.490343031199;9549.588028746151 22:18:58 INFO - PROCESS | 25211 | __end_tp_report 22:18:58 INFO - PROCESS | 25211 | __start_cc_report 22:18:58 INFO - PROCESS | 25211 | _x_x_mozilla_cycle_collect,1070 22:18:58 INFO - PROCESS | 25211 | __end_cc_report 22:18:58 INFO - PROCESS | 25211 | __startTimestamp1460006338008__endTimestamp 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - PROCESS | 25211 | ------- Summary: start ------- 22:18:58 INFO - PROCESS | 25211 | Number of tests: 6 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - PROCESS | 25211 | [#0] dojo.html Cycles:165 Average:4637.63 Median:4764.26 stddev:479.89 (10.1%) stddev-sans-first:453.94 22:18:58 INFO - PROCESS | 25211 | Values: 2599.4 2661.1 2670.3 2680.0 2713.7 4569.5 4659.6 4667.1 4679.9 4684.0 4570.8 4579.2 4689.2 4712.6 4714.7 4241.8 4282.9 4299.3 4352.9 4432.4 4348.0 4378.8 4395.4 4406.0 4409.6 4196.1 4284.3 4320.9 4330.5 4405.8 4300.5 4314.1 4349.2 4351.9 4374.7 4279.4 4289.9 4303.1 4316.2 4332.0 4486.9 4501.4 4531.6 4570.4 4610.2 4998.6 5011.0 5015.1 5027.6 5058.7 5027.9 5044.8 5048.0 5051.0 5084.5 4611.7 4655.4 4694.2 4700.9 4735.2 5208.3 5209.0 5215.8 5233.4 5245.8 4988.9 4992.7 4997.9 4998.5 5045.4 4907.0 4959.7 5004.3 5061.1 5071.6 4919.8 4928.8 4939.2 4945.8 4997.3 4915.8 4925.6 4926.4 4927.7 4972.8 4147.8 4213.3 4222.3 4279.3 4293.7 3712.8 3740.3 3747.6 3750.3 3760.8 4345.0 4346.7 4350.6 4359.9 4388.9 4941.4 5011.0 5016.9 5105.5 5113.2 4328.2 4334.9 4335.3 4337.1 4378.8 4508.9 4512.5 4520.3 4521.9 4527.5 4559.4 4759.2 4799.3 4810.2 4846.2 5013.7 5017.1 5034.6 5041.8 5079.2 4630.5 4743.6 4758.0 4760.7 4795.2 4944.4 4980.3 4988.6 5014.8 5027.4 5017.6 5055.3 5056.8 5057.6 5108.9 4700.5 4824.4 4906.8 4919.1 4964.5 4833.6 4854.3 4865.4 4869.7 4905.9 4772.7 4782.7 4797.4 4801.9 4827.2 4764.3 4855.7 4900.5 4908.6 4926.1 4779.5 4781.0 4801.5 4815.3 4845.6 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - PROCESS | 25211 | [#1] ext.html Cycles:180 Average:40114.43 Median:18933.38 stddev:62693.92 (331.1%) stddev-sans-first:62799.37 22:18:58 INFO - PROCESS | 25211 | Values: 537.6 541.5 556.1 560.3 576.1 27476.6 34627.5 35428.0 35438.8 35464.3 38686.6 39127.2 39152.8 39163.4 39182.2 7533.7 7701.2 7715.8 7719.7 7724.7 7605.4 7727.5 7732.2 7734.7 7876.9 7819.7 7876.0 7884.0 7889.6 7897.1 7796.3 7858.4 7868.3 7868.6 7872.0 7681.3 7795.3 7797.3 7802.8 7807.6 38560.6 39081.8 39095.4 39120.2 39157.0 3077.9 3215.0 3218.5 3501.9 3736.2 28839.6 28880.7 29273.3 29659.6 29819.6 3322.4 3432.4 3443.8 3447.2 3486.0 234601.0 236520.0 236532.0 237347.0 237782.0 53382.7 53522.0 53677.5 53767.0 53777.2 55557.4 56728.4 56836.7 58311.0 59059.2 12667.4 12742.2 12814.5 12879.1 12879.9 10210.9 10213.6 10217.8 10226.8 10269.8 16475.9 16895.5 18824.7 18933.0 19147.4 6923.0 7028.9 7075.9 7158.2 7267.3 884.8 936.5 941.7 1017.3 1036.1 25807.2 27175.2 27298.5 27462.5 27565.2 997.9 1024.7 1037.5 1064.5 1068.0 13884.7 14277.1 14551.3 14588.3 14595.4 276205.0 281304.0 281641.0 281853.0 282746.0 43860.0 45743.8 45802.0 45875.8 45882.5 1093.5 1244.1 1262.7 1277.1 1325.6 26365.5 27314.2 27356.9 28081.3 28171.4 37758.8 38292.2 38367.4 38431.6 38446.6 193486.0 197686.0 198352.0 198465.0 198850.0 27386.7 29742.0 31034.0 31637.8 31669.0 36912.8 37938.1 38046.0 38177.6 38419.6 33232.7 34423.0 34681.1 35130.3 35440.8 33814.5 34123.8 34336.0 34382.7 34745.3 33858.3 34284.0 34419.0 34434.0 34843.0 30210.8 31221.4 31667.7 31690.5 31721.8 24107.3 24449.8 24459.5 24677.8 24796.5 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - PROCESS | 25211 | [#2] jquery.html Cycles:180 Average:22667.75 Median:5156.07 stddev:63306.79 (1227.8%) stddev-sans-first:63462.19 22:18:58 INFO - PROCESS | 25211 | Values: 340.4 342.8 344.8 344.8 349.6 14654.3 15203.2 15812.0 16400.1 16438.0 15475.1 15764.9 16071.0 16170.7 16176.7 4767.3 4920.9 4925.4 4937.6 4958.1 4973.8 5158.7 5165.7 5188.7 5192.4 5126.9 5169.4 5173.1 5176.1 5179.5 4967.2 5153.5 5174.2 5179.2 5179.6 4954.2 4977.6 4980.5 4996.8 5005.2 11381.4 16255.8 17942.5 17977.3 17985.2 1908.2 1973.9 1995.1 2012.8 2020.9 8715.9 8820.8 9085.5 9207.7 11788.0 1726.8 1761.9 1775.4 1794.3 1809.4 54315.7 59576.0 59730.0 60076.7 60147.4 9209.4 9283.7 9324.0 9519.8 9540.5 12712.9 12868.0 12894.0 12910.9 12913.9 7029.2 7161.9 7171.4 7289.9 7332.5 6985.9 7072.7 7081.1 7098.8 7120.7 4135.7 4149.9 4159.8 4203.5 4204.1 1697.4 1749.6 1750.8 1767.5 1770.7 826.9 879.4 917.9 936.4 939.9 14385.6 15070.0 15318.6 15525.8 15566.4 843.1 850.5 882.7 888.8 910.5 8562.2 8649.4 8723.0 8986.3 8987.8 376075.0 380569.0 385698.0 389752.0 397510.0 51121.2 63883.0 66054.7 66920.3 68583.7 898.9 921.9 934.9 940.1 942.1 13640.2 14048.5 14147.0 14256.8 14311.9 31315.8 32216.2 32648.0 32831.0 32927.8 43220.4 44775.0 44956.8 45421.8 45488.8 6824.9 6897.8 6981.4 7004.6 7071.0 10055.3 10408.9 10410.6 10445.5 10530.1 8423.2 9030.5 9045.8 9298.9 9401.9 8835.8 8962.0 8970.0 9242.4 9255.6 9089.6 9215.1 9346.9 9375.2 9473.0 6680.7 6732.9 6787.3 6825.5 6938.8 9087.6 9188.2 9391.9 9431.0 9508.0 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - PROCESS | 25211 | [#3] mootools.html Cycles:180 Average:5344.37 Median:6375.04 stddev:2838.22 (44.5%) stddev-sans-first:2830.04 22:18:58 INFO - PROCESS | 25211 | Values: 1317.4 1402.9 1423.8 1550.0 1761.5 6701.6 7387.3 7548.0 7548.3 7551.9 7339.6 7516.1 7524.9 7535.9 7538.9 1863.0 1914.1 2225.3 2230.1 2261.8 2189.7 2201.3 2203.5 2204.5 2204.9 2219.0 2241.7 2280.2 2282.3 2282.3 2193.2 2226.1 2237.8 2238.0 2243.3 2186.8 2193.2 2216.0 2216.3 2218.0 7739.0 7797.3 7803.8 7808.5 7815.2 4538.2 4603.4 4638.1 4639.6 4640.7 2879.4 2909.8 2915.9 2917.7 3062.6 977.9 980.9 992.4 992.8 1002.9 10259.8 10320.8 10382.3 10394.5 10412.2 4095.2 4245.1 4286.7 4311.1 4311.7 8839.5 8872.9 8885.7 8910.4 8914.2 4592.5 4605.4 4618.3 4620.4 4627.8 3778.3 4089.6 4213.9 4240.8 4247.8 3616.6 3669.4 3687.8 3699.8 3770.7 1205.7 1211.6 1218.3 1220.8 1222.9 972.8 984.3 991.2 1040.4 1199.3 7218.3 7247.5 7257.1 7289.0 7291.7 456.8 458.4 459.6 460.2 461.3 5464.8 5503.8 5508.8 5516.3 5558.8 9424.2 9735.3 9754.3 9769.5 9781.8 9190.2 9543.5 9545.8 9592.9 9607.8 7326.6 7336.0 7416.8 7449.2 7484.1 6897.7 6990.5 6994.5 6997.7 7001.8 8374.1 8376.0 8532.0 8550.9 8632.4 8609.7 8663.8 8664.6 8753.4 8825.8 5685.8 6308.5 6462.4 6651.6 6722.7 7158.1 7159.9 7197.5 7214.7 7242.1 6310.4 6723.6 6724.3 6810.9 6842.8 6654.5 6665.7 6689.6 6707.4 6724.2 6852.1 6891.1 6961.1 6961.7 6965.8 6300.5 6362.2 6366.2 6369.3 6380.7 6324.4 6382.2 6384.4 6386.8 6400.7 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - PROCESS | 25211 | [#4] prototype.html Cycles:180 Average:4607.17 Median:5297.89 stddev:1359.29 (25.7%) stddev-sans-first:1324.27 22:18:58 INFO - PROCESS | 25211 | Values: 309.4 309.8 316.9 321.5 322.7 5224.6 5304.0 5318.2 5330.7 5357.8 5243.6 5258.5 5260.1 5288.0 5291.8 3944.1 4006.7 4084.9 4103.7 4115.5 4092.5 4098.2 4106.9 4111.1 4112.9 4056.5 4060.4 4068.1 4068.8 4069.1 3927.3 4010.9 4098.1 4102.9 4104.0 3612.9 3613.2 3616.0 3618.9 3625.3 5093.1 5099.2 5105.0 5105.9 5111.2 4720.9 4722.3 4725.9 4732.5 4736.7 5538.8 5541.6 5542.9 5543.3 5550.6 3951.3 3959.6 3968.8 3975.7 3976.4 5585.5 5838.3 5847.9 5852.6 5861.3 3893.4 3930.8 3934.4 3936.9 3945.3 3991.0 3992.0 3996.1 3996.6 3998.3 4604.9 4611.8 4613.4 4619.6 4624.7 5562.8 5565.4 5573.2 5573.3 5574.7 1393.5 1418.5 1419.9 1420.6 1421.5 882.6 908.2 922.5 925.9 949.4 4860.3 4865.1 4886.8 4894.3 4896.2 5695.7 5698.7 5699.3 5700.2 5702.1 4870.7 4882.0 4882.1 4884.2 4890.3 3028.7 3057.3 3063.4 3073.0 3075.9 5379.9 5386.1 5390.7 5392.4 5396.4 5746.3 5850.2 5955.1 5972.5 5984.0 5478.0 5492.9 5497.4 5497.5 5513.6 5829.9 5834.2 5836.2 5840.8 5843.4 5672.1 5684.1 5685.5 5693.1 5695.8 5486.1 5491.2 5494.6 5502.7 5505.0 3808.8 3902.4 3927.0 3931.6 3935.7 5607.4 5638.2 5645.1 5650.7 5659.6 5473.9 5474.2 5539.1 5575.6 5583.4 5562.0 5564.1 5573.1 5574.3 5587.5 5489.9 5493.0 5500.5 5501.5 5503.7 5451.1 5587.2 5604.1 5604.3 5613.4 5432.6 5461.5 5464.9 5473.2 5486.6 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - PROCESS | 25211 | [#5] yui.html Cycles:180 Average:12327.68 Median:42077.39 stddev:13768.74 (32.7%) stddev-sans-first:13779.55 22:18:58 INFO - PROCESS | 25211 | Values: 675.7 677.6 704.8 733.5 755.6 11342.1 11386.4 11434.8 11439.5 11594.8 11576.5 11705.9 11770.8 11848.3 11864.6 646.6 660.7 804.6 819.4 819.7 787.6 816.9 816.9 817.3 817.9 837.6 847.4 848.2 849.2 849.9 669.8 804.2 839.3 845.9 852.8 618.7 620.5 621.1 621.4 623.4 11158.7 11197.3 11203.6 11206.3 11216.9 11399.8 12476.9 12514.6 12654.7 12748.7 10131.3 10173.9 10232.5 10245.2 10280.1 3245.8 3274.4 3287.4 3335.3 3385.2 41793.4 41921.6 42033.8 42121.0 42298.0 9991.9 10029.5 10032.1 10199.5 10211.2 17622.9 17830.2 17851.6 17989.2 18041.5 6859.6 6949.6 6975.1 7001.4 7028.4 3681.4 3707.5 3723.0 3753.7 3761.4 2776.6 2786.8 2802.3 2807.3 2809.1 485.5 488.7 495.3 506.6 548.3 583.4 583.5 589.1 589.2 589.4 8136.8 8347.4 8464.3 8544.5 8665.6 561.0 595.0 611.7 616.7 623.8 3691.2 3756.9 3927.6 3937.6 4033.8 48372.3 48463.8 49402.8 49458.3 49586.5 42901.0 43484.0 43738.3 44002.6 45345.8 38740.4 39630.2 40594.4 40677.4 40834.2 7407.8 7658.0 7665.7 7750.7 7850.7 30922.8 31429.0 32013.2 32016.7 32019.8 37083.8 38405.4 40054.8 40249.8 40315.0 9446.7 9451.2 9546.2 9581.8 9641.0 10235.2 10241.2 10344.6 10447.8 10627.3 8457.6 10550.0 10607.9 10613.9 10756.8 10369.0 10417.7 10482.8 10511.2 10877.5 10176.9 10514.6 10965.2 11017.8 11123.3 9159.1 9312.3 9331.7 9417.9 9494.6 8790.9 8957.0 9222.9 9266.5 9549.6 22:18:58 INFO - PROCESS | 25211 | -------- Summary: end -------- 22:18:58 INFO - PROCESS | 25211 | 22:18:58 INFO - TEST-INFO | 25211: exit 0 22:18:58 INFO - TEST-OK | dromaeo_css | took 1116775ms 22:18:58 INFO - TEST-START | kraken 22:18:58 INFO - operating with platform_type : linux_ 22:18:58 INFO - Initialising browser for kraken test... 22:18:58 INFO - TEST-INFO | started process 25390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDlLp1k/profile http://localhost:32870/getInfo.html) 22:19:03 INFO - PROCESS | 25390 | __metrics Screen width/height:1600/1200 22:19:03 INFO - PROCESS | 25390 | colorDepth:24 22:19:03 INFO - PROCESS | 25390 | Browser inner width/height: 1024/697 22:19:03 INFO - PROCESS | 25390 | __metrics 22:19:04 ERROR - PROCESS | 25390 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:19:05 INFO - TEST-INFO | 25390: exit 0 22:19:05 INFO - Browser initialized. 22:19:05 INFO - Running cycle 1/1 for kraken test... 22:19:05 INFO - TEST-INFO | started process 25473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDlLp1k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:17 INFO - PROCESS | 25473 | RSS: Main: 154038272 22:19:17 INFO - PROCESS | 25473 | 22:19:19 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32870/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:20 INFO - PROCESS | 25473 | RSS: Main: 194961408 22:19:20 INFO - PROCESS | 25473 | 22:19:23 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32870/tests/kraken/driver.html?testName=audio-dft) 22:19:23 INFO - PROCESS | 25473 | RSS: Main: 184958976 22:19:23 INFO - PROCESS | 25473 | 22:19:26 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32870/tests/kraken/driver.html?testName=audio-fft) 22:19:27 INFO - PROCESS | 25473 | RSS: Main: 169193472 22:19:27 INFO - PROCESS | 25473 | 22:19:29 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32870/tests/kraken/driver.html?testName=audio-oscillator) 22:19:29 INFO - PROCESS | 25473 | RSS: Main: 172367872 22:19:29 INFO - PROCESS | 25473 | 22:19:32 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:32 INFO - PROCESS | 25473 | RSS: Main: 173903872 22:19:32 INFO - PROCESS | 25473 | 22:19:35 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32870/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:36 INFO - PROCESS | 25473 | RSS: Main: 174108672 22:19:36 INFO - PROCESS | 25473 | 22:19:39 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32870/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:40 INFO - PROCESS | 25473 | RSS: Main: 174751744 22:19:40 INFO - PROCESS | 25473 | 22:19:43 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32870/tests/kraken/driver.html?testName=json-parse-financial) 22:19:43 INFO - PROCESS | 25473 | RSS: Main: 174829568 22:19:43 INFO - PROCESS | 25473 | 22:19:45 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:46 INFO - PROCESS | 25473 | RSS: Main: 183050240 22:19:46 INFO - PROCESS | 25473 | 22:19:47 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32870/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:48 INFO - PROCESS | 25473 | RSS: Main: 180867072 22:19:48 INFO - PROCESS | 25473 | 22:19:50 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:51 INFO - PROCESS | 25473 | RSS: Main: 193884160 22:19:51 INFO - PROCESS | 25473 | 22:19:53 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:54 INFO - PROCESS | 25473 | RSS: Main: 197918720 22:19:54 INFO - PROCESS | 25473 | 22:19:56 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:57 INFO - PROCESS | 25473 | RSS: Main: 197214208 22:19:57 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | Cycle 1(1): loaded http://localhost:32870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32870/tests/kraken/driver.html?testName=ai-astar) 22:19:59 INFO - PROCESS | 25473 | RSS: Main: 259338240 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | __start_tp_report 22:19:59 INFO - PROCESS | 25473 | _x_x_mozilla_page_load 22:19:59 INFO - PROCESS | 25473 | _x_x_mozilla_page_load_details 22:19:59 INFO - PROCESS | 25473 | |i|pagename|runs| 22:19:59 INFO - PROCESS | 25473 | |0;ai-astar;113;114;106;112;114;113;102;114;112;113 22:19:59 INFO - PROCESS | 25473 | |1;audio-beat-detection;168;139;155;174;138;159;156;135;184;132 22:19:59 INFO - PROCESS | 25473 | |2;audio-dft;162;162;162;160;160;160;164;162;163;160 22:19:59 INFO - PROCESS | 25473 | |3;audio-fft;74;74;108;101;73;73;75;120;108;74 22:19:59 INFO - PROCESS | 25473 | |4;audio-oscillator;94;94;146;94;94;94;140;93;95;139 22:19:59 INFO - PROCESS | 25473 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;116;117;117 22:19:59 INFO - PROCESS | 25473 | |6;imaging-darkroom;146;146;146;146;147;146;146;147;147;147 22:19:59 INFO - PROCESS | 25473 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;96;95 22:19:59 INFO - PROCESS | 25473 | |8;json-parse-financial;67;66;69;66;65;66;66;74;63;64 22:19:59 INFO - PROCESS | 25473 | |9;json-stringify-tinderbox;63;63;63;63;63;64;64;65;64;64 22:19:59 INFO - PROCESS | 25473 | |10;stanford-crypto-aes;84;83;84;91;92;84;84;83;83;82 22:19:59 INFO - PROCESS | 25473 | |11;stanford-crypto-ccm;129;122;125;117;117;124;118;119;117;121 22:19:59 INFO - PROCESS | 25473 | |12;stanford-crypto-pbkdf2;142;132;152;153;142;133;149;144;147;142 22:19:59 INFO - PROCESS | 25473 | |13;stanford-crypto-sha256-iterative;69;67;69;69;68;69;68;69;66;66 22:19:59 INFO - PROCESS | 25473 | __end_tp_report 22:19:59 INFO - PROCESS | 25473 | __start_cc_report 22:19:59 INFO - PROCESS | 25473 | _x_x_mozilla_cycle_collect,1197 22:19:59 INFO - PROCESS | 25473 | __end_cc_report 22:19:59 INFO - PROCESS | 25473 | __startTimestamp1460006399580__endTimestamp 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | ------- Summary: start ------- 22:19:59 INFO - PROCESS | 25473 | Number of tests: 14 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:4.03 (3.6%) stddev-sans-first:4.23 22:19:59 INFO - PROCESS | 25473 | Values: 113.0 114.0 106.0 112.0 114.0 113.0 102.0 114.0 112.0 113.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#1] audio-beat-detection Cycles:10 Average:154.00 Median:157.50 stddev:17.80 (11.3%) stddev-sans-first:18.15 22:19:59 INFO - PROCESS | 25473 | Values: 168.0 139.0 155.0 174.0 138.0 159.0 156.0 135.0 184.0 132.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 22:19:59 INFO - PROCESS | 25473 | Values: 162.0 162.0 162.0 160.0 160.0 160.0 164.0 162.0 163.0 160.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#3] audio-fft Cycles:10 Average:88.00 Median:73.50 stddev:18.86 (25.7%) stddev-sans-first:19.31 22:19:59 INFO - PROCESS | 25473 | Values: 74.0 74.0 108.0 101.0 73.0 73.0 75.0 120.0 108.0 74.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:23.10 (24.6%) stddev-sans-first:23.91 22:19:59 INFO - PROCESS | 25473 | Values: 94.0 94.0 146.0 94.0 94.0 94.0 140.0 93.0 95.0 139.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:19:59 INFO - PROCESS | 25473 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:19:59 INFO - PROCESS | 25473 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:19:59 INFO - PROCESS | 25473 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.00 stddev:3.06 (4.6%) stddev-sans-first:3.24 22:19:59 INFO - PROCESS | 25473 | Values: 67.0 66.0 69.0 66.0 65.0 66.0 66.0 74.0 63.0 64.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 22:19:59 INFO - PROCESS | 25473 | Values: 63.0 63.0 63.0 63.0 63.0 64.0 64.0 65.0 64.0 64.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.50 (4.2%) stddev-sans-first:3.69 22:19:59 INFO - PROCESS | 25473 | Values: 84.0 83.0 84.0 91.0 92.0 84.0 84.0 83.0 83.0 82.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.50 stddev:4.09 (3.4%) stddev-sans-first:3.12 22:19:59 INFO - PROCESS | 25473 | Values: 129.0 122.0 125.0 117.0 117.0 124.0 118.0 119.0 117.0 121.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:145.50 stddev:7.11 (4.9%) stddev-sans-first:7.51 22:19:59 INFO - PROCESS | 25473 | Values: 142.0 132.0 152.0 153.0 142.0 133.0 149.0 144.0 147.0 142.0 22:19:59 INFO - PROCESS | 25473 | 22:19:59 INFO - PROCESS | 25473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.27 22:19:59 INFO - PROCESS | 25473 | Values: 69.0 67.0 69.0 69.0 68.0 69.0 68.0 69.0 66.0 66.0 22:19:59 INFO - PROCESS | 25473 | -------- Summary: end -------- 22:19:59 INFO - PROCESS | 25473 | 22:20:00 INFO - TEST-INFO | 25473: exit 0 22:20:00 INFO - TEST-OK | kraken | took 61834ms 22:20:00 INFO - SUITE-END | took 1178s 22:20:00 INFO - Completed test suite (00:19:38) 22:20:00 INFO - javascript benchmark 22:20:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2599.3631560267736, 2661.055325359497, 2670.3146374829003, 2679.9866000669995, 2713.7421944915227, 4569.497355290923, 4659.580637742602, 4667.136579732752, 4679.906401871961, 4684.039771846772, 4570.817167313312, 4579.152856721509, 4689.155951928651, 4712.599429048535, 4714.717116972984, 4241.787910604473, 4282.914341713172, 4299.269124248885, 4352.869413917588, 4432.445944256968, 4348.0, 4378.759168245745, 4395.384646149541, 4406.0, 4409.603135717784, 4196.139791342767, 4284.250256205151, 4320.891977700567, 4330.523642399334, 4405.845795397146, 4300.462442194726, 4314.072474418015, 4349.238883195429, 4351.934720979188, 4374.693771436001, 4279.358096285551, 4289.871303860889, 4303.139372125587, 4316.201502722007, 4331.956680433187, 4486.9326960095295, 4501.414816073922, 4531.592156705912, 4570.382998295221, 4610.216263235258, 4998.550130488274, 5011.0, 5015.072211640858, 5027.648064635477, 5058.696478211319, 5027.949720502821, 5044.848654540333, 5048.0, 5051.0, 5084.542391184774, 4611.654125940568, 4655.441347038377, 4694.24892017279, 4700.929486057677, 4735.2186889163595, 5208.348956380452, 5208.9739551302, 5215.765290561933, 5233.4243233244315, 5245.816396426107, 4988.925166122439, 4992.675476094042, 4997.90004199914, 4998.450170481244, 5045.41977672565, 4906.950930490721, 4959.7272150032095, 5004.349434573555, 5061.089003979319, 5071.594272458195, 4919.827806026772, 4928.778204980785, 4939.234418665113, 4945.802167913315, 4997.325361076281, 4915.827946021872, 4925.630577706686, 4926.433460152057, 4927.728974906415, 4972.825951091694, 4147.834086636501, 4213.2837417639075, 4222.3244280914905, 4279.33670281107, 4293.699441039097, 3712.777233366007, 3740.2706472238197, 3747.6065013173225, 3750.268697603941, 3760.7743535387963, 4344.978275108604, 4346.6522678185665, 4350.58669426404, 4359.934600980988, 4388.934165987513, 4941.407031156213, 5011.047900898818, 5016.949830501649, 5105.5149760772665, 5113.233015047773, 4328.177646247203, 4334.891627709332, 4335.34969754533, 4337.067530480962, 4378.846740364072, 4508.864734057918, 4512.548745125527, 4520.321951707205, 4521.864344069683, 4527.47933987589, 4559.361689363492, 4759.1671457495495, 4799.304100905419, 4810.206315957827, 4846.200376937766, 5013.724245166551, 5017.12200364942, 5034.572061374678, 5041.798328066836, 5079.187330027178, 4630.467496237976, 4743.620510359094, 4758.048390322018, 4760.738159401266, 4795.160846851717, 4944.3572335596145, 4980.277859710394, 4988.600911927109, 5014.824481143142, 5027.371578552681, 5017.57350625201, 5055.34280543527, 5056.84829455117, 5057.570106540985, 5108.923366149436, 4700.529947005272, 4824.372831531879, 4906.779194936165, 4919.065377578248, 4964.478729733326, 4833.613310935047, 4854.344663470528, 4865.440474345495, 4869.732164730974, 4905.9018819624125, 4772.6659133861685, 4782.736949467812, 4797.352357431702, 4801.927971080507, 4827.203511420576, 4764.2615394613895, 4855.6601037927, 4900.534449227318, 4908.631852610997, 4926.064047830901, 4779.545943135397, 4780.976095119502, 4801.4718380977365, 4815.3499277597075, 4845.563899249085], "unit": "score", "name": "dojo.html", "value": 4607.7129039660895}, {"lowerIsBetter": false, "replicates": [537.6156048425376, 541.5315751874629, 556.1296570866596, 560.3080195957992, 576.0610205365253, 27476.587851182223, 34627.4805877912, 35428.0, 35438.82280588593, 35464.290714185736, 38686.613133868654, 39127.21745565094, 39152.80423597878, 39163.41254881179, 39182.21635567287, 7533.736319228814, 7701.152873183945, 7715.845683086335, 7719.691212351499, 7724.652390642406, 7605.391568674493, 7727.536347819121, 7732.188120247378, 7734.729284475045, 7876.881846772274, 7819.687212511492, 7876.0, 7884.0, 7889.644965976516, 7897.052353717533, 7796.337311328515, 7858.449908506407, 7868.25251601097, 7868.567228802413, 7871.960640196791, 7681.270279323456, 7795.33739632132, 7797.298243158143, 7802.765917022499, 7807.6096195190585, 38560.61439385598, 39081.80459097686, 39095.41356879649, 39120.21759564821, 39157.0, 3077.861496232675, 3214.9839250803598, 3218.5494030835703, 3501.859925602973, 3736.196717705679, 28839.56740648871, 28880.71119288801, 29273.268168295752, 29659.55510667342, 29819.552706709415, 3322.435186018383, 3432.390571384448, 3443.7589368743947, 3447.1554469154967, 3486.0064881508647, 234601.0, 236520.0, 236532.0, 237347.0, 237782.0, 53382.73308633432, 53522.0, 53677.463225367246, 53767.0, 53777.1933420999, 55557.44442555604, 56728.432715672316, 56836.715816420656, 58311.0, 59059.161154524816, 12667.429965651569, 12742.235465871892, 12814.487420503261, 12879.098463107492, 12879.871201288055, 10210.897891021143, 10213.642522511676, 10217.795644087077, 10226.795464090825, 10269.794604107876, 16475.917620411823, 16895.493135205965, 18824.717629235573, 18933.0, 19147.425577232705, 6922.965385173042, 7028.929710702828, 7075.893861592081, 7158.176809666851, 7267.273272672691, 884.7611144990816, 936.5317341329335, 941.7268991992382, 1017.3438132404558, 1036.108946306176, 25807.225783226535, 27175.1847444577, 27298.45403091927, 27462.45075098487, 27565.17304480869, 997.9002099789963, 1024.6721049264313, 1037.4708898461838, 1064.4518073192312, 1068.0014186735427, 13884.722305553832, 14277.14337139775, 14551.27243637835, 14588.34352454142, 14595.372832890182, 276205.0, 281304.0, 281641.0, 281853.0, 282746.0, 43860.0, 45743.77128114338, 45802.0, 45875.77062114735, 45882.54117458849, 1093.5188517052472, 1244.147758785235, 1262.6969527313563, 1277.067740549404, 1325.5691900132495, 26365.4726905457, 27314.180574582795, 27356.863215683796, 28081.297967550974, 28171.43657126887, 37758.81120594379, 38292.234155317296, 38367.42448863213, 38431.61568384281, 38446.615533844306, 193486.0, 197686.0, 198352.0, 198465.0, 198850.0, 27386.72613273842, 29742.0, 31034.0, 31637.8418107908, 31669.0, 36912.81543592265, 37938.051548711504, 38046.0, 38177.618223818514, 38419.615803842724, 33232.66767332392, 34423.0, 34681.1329716749, 35130.29739405249, 35440.822795885855, 33814.49278260779, 34123.829380852934, 34336.0, 34382.65617343794, 34745.30509389849, 33858.32283354369, 34284.0, 34419.0, 34434.0, 34843.0, 30210.84894575513, 31221.37557248797, 31667.683323166475, 31690.524642130847, 31721.8413907929, 24107.27678169658, 24449.755502444747, 24459.51080978406, 24677.753222468265, 24796.50406991886], "unit": "score", "name": "ext.html", "value": 16879.705173367565}, {"lowerIsBetter": false, "replicates": [340.4093897088551, 342.8268724294232, 344.80690813144656, 344.8344794498639, 349.57177457614426, 14654.267286635652, 15203.239838008098, 15812.0, 16400.097994610293, 16438.0, 15475.14886681232, 15764.921175394107, 16070.99999999997, 16170.676586468293, 16176.676466470664, 4767.261074533453, 4920.901581968358, 4925.408950925876, 4937.580305674022, 4958.107540642683, 4973.751312434382, 5158.664686795346, 5165.664231824938, 5188.7146206958605, 5192.376914770233, 5126.897462050757, 5169.431362550116, 5173.068847607429, 5176.145935920568, 5179.4561571035065, 4967.155583550787, 5153.484651534854, 5174.2238664200295, 5179.19722443022, 5179.585633149339, 4954.157793175169, 4977.626677999165, 4980.526849949285, 4996.825111121129, 5005.2492126181, 11381.374024428653, 16255.756163657554, 17942.461726148238, 17977.280908763634, 17985.190666420043, 1908.1794828223858, 1973.9111739971593, 1995.1420889017716, 2012.7584689837167, 2020.929267475646, 8715.869261961076, 8820.779480512974, 9085.454872707593, 9207.677731279373, 11788.0, 1726.8273172682757, 1761.867859910499, 1775.3697437409662, 1794.2912549542857, 1809.4390738870993, 54315.728421358035, 59576.0, 59730.0, 60076.699616502076, 60147.39852601506, 9209.355345125778, 9283.72148835536, 9323.953380233055, 9519.762005949906, 9540.475273860004, 12712.872871271355, 12868.0, 12894.0, 12910.9354453229, 12913.935430322788, 7029.22678505364, 7161.89257161143, 7171.354578087997, 7289.890651640229, 7332.486725929134, 6985.93014069863, 7072.71709131629, 7081.114860642419, 7098.751543695946, 7120.679569419389, 4135.710500265012, 4149.937750933738, 4159.771212583277, 4203.495580530356, 4204.138151678899, 1697.4483292929847, 1749.553863764732, 1750.8336708012719, 1767.4962635649035, 1770.6724256012678, 826.8842362069315, 879.445949052093, 917.898521773874, 936.3960245641523, 939.9342046056711, 14385.64035899111, 15070.0, 15318.617034574001, 15525.844741552666, 15566.377344906303, 843.1231519220065, 850.5279569838675, 882.7219425880827, 888.7555922121468, 910.4855756497558, 8562.186592273723, 8649.394542381973, 8723.0, 8986.281097512183, 8987.775305617412, 376075.0, 380569.0, 385698.0, 389752.0, 397510.0, 51121.233181502306, 63883.0, 66054.66972665202, 66920.33079669239, 68583.65708171428, 898.9460632362079, 921.870938068671, 934.9298802589697, 940.1256831147099, 942.1050002497655, 13640.181589104686, 14048.508302209782, 14147.0, 14256.786148207993, 14311.856881431053, 31315.84342078275, 32216.19459513531, 32648.0, 32831.0, 32927.83536082304, 43220.351694725236, 44775.0, 44956.77521612502, 45421.77289113666, 45488.77255613701, 6824.863502730017, 6897.7585784497305, 6981.441484681111, 7004.649767511706, 7070.964645176947, 10055.346402483816, 10408.895911040792, 10410.635627752992, 10445.529951152368, 10530.104941080093, 8423.157684231774, 9030.503322317072, 9045.819083618158, 9298.860517092384, 9401.918779340464, 8835.823283534164, 8961.955190224007, 8970.0, 9242.399244049115, 9255.629774809202, 9089.590968406304, 9215.078492150731, 9346.859797102912, 9375.203107735919, 9472.95263523678, 6680.732770689118, 6732.865342693217, 6787.287334829772, 6825.52221344521, 6938.757143499954, 9087.59105840252, 9188.173064424234, 9391.906080939103, 9431.0, 9507.952460237655], "unit": "score", "name": "jquery.html", "value": 7665.843071454826}, {"lowerIsBetter": false, "replicates": [1317.446672397593, 1402.894782891283, 1423.8077859488965, 1549.9612509687256, 1761.471558532439, 6701.59790412575, 7387.26127387261, 7547.962260188691, 7548.320651141396, 7551.92448075519, 7339.59632220229, 7516.060492438445, 7524.924750752491, 7535.886961695579, 7538.924610753891, 1862.9627407451842, 1914.1003728247701, 2225.2656623314347, 2230.074519074586, 2261.807746341563, 2189.6824960380736, 2201.3175915466177, 2203.537257175995, 2204.4709269775217, 2204.911803527857, 2219.0, 2241.7085778848727, 2280.2133264023887, 2282.3038973113194, 2282.315305408379, 2193.2214064007208, 2226.1318085946496, 2237.8209743220505, 2238.0488292475716, 2243.293362590795, 2186.8469207155504, 2193.243331050785, 2215.9778402215934, 2216.34617787753, 2218.024069409471, 7738.961305193494, 7797.298243158086, 7803.8439231215625, 7808.5314881107315, 7815.218478152139, 4538.205813982539, 4603.401557797499, 4638.095571363586, 4639.5824375806005, 4640.67515273931, 2879.4097210071886, 2909.796314258003, 2915.8833646654107, 2917.6644685861183, 3062.617172853393, 977.8679878216492, 980.9068138526828, 992.4343124419084, 992.8163289791412, 1002.8846682631518, 10259.794804103876, 10320.79358412835, 10382.325148865375, 10394.532246048946, 10412.219083568763, 4095.1604920991126, 4245.087306229176, 4286.721363111388, 4311.094670119247, 4311.719738217006, 8839.46963182211, 8872.8669069964, 8885.733427997042, 8910.420822646507, 8914.153155450222, 4592.494825569184, 4605.355250264965, 4618.284165954283, 4620.445546534437, 4627.838025669153, 3778.282126396031, 4089.6114869087387, 4213.894652633709, 4240.766757828287, 4247.787610619518, 3616.5840928293583, 3669.43123815809, 3687.815609219528, 3699.8335074921692, 3770.7360484765804, 1205.6925484001524, 1211.612284069107, 1218.3481837217046, 1220.798568236249, 1222.9205101668363, 972.8492083727034, 984.2814745236018, 991.1723710701501, 1040.3913710479455, 1199.322382853685, 7218.314260145278, 7247.4926755126635, 7257.129144502694, 7289.0, 7291.708331666674, 456.83734894693083, 458.3903408466731, 459.59785187960534, 460.24979283767243, 461.3264633634931, 5464.754086066137, 5503.834884953458, 5508.834734957958, 5516.3380394352935, 5558.77764889408, 9424.151826335663, 9735.318527702993, 9754.268429867789, 9769.51152442375, 9781.755456113511, 9190.172884440433, 9543.47510886894, 9545.761355966157, 9592.904070959341, 9607.807843843084, 7326.633668316563, 7335.963320183365, 7416.814579635445, 7449.180590135081, 7484.101907771103, 6897.7240910363025, 6990.475714321548, 6994.510384273256, 6997.720091196499, 7001.754938577125, 8374.07885132647, 8375.95812020936, 8531.957340213508, 8550.91449085526, 8632.352573556882, 8609.65561377538, 8663.826723465621, 8664.610092545725, 8753.431026983226, 8825.779355516164, 5685.77256909719, 6308.495320374451, 6462.3537646235, 6651.63416012124, 6722.697478613376, 7158.105236845395, 7159.856802863809, 7197.532160409557, 7214.71141154348, 7242.058532390755, 6310.400511951358, 6723.630200339028, 6724.327567243236, 6810.8637827244165, 6842.8289292766085, 6654.467642588678, 6665.700043498151, 6689.632070236184, 6707.429868461236, 6724.193096828412, 6852.109225800614, 6891.138607674041, 6961.060256865461, 6961.686724097529, 6965.79102626922, 6300.495960323255, 6362.204724409449, 6366.236051673829, 6369.33122022181, 6380.7447702091395, 6324.367563243639, 6382.234131904202, 6384.3934826191435, 6386.840328991812, 6400.743970241138], "unit": "score", "name": "mootools.html", "value": 4285.640010008038}, {"lowerIsBetter": false, "replicates": [309.4013084681142, 309.7986308899216, 316.9160172554273, 321.4663658327176, 322.65959412819495, 5224.63427560071, 5304.018756530045, 5318.175682769167, 5330.653507522008, 5357.8392648220515, 5243.632945693803, 5258.474152584749, 5260.132078207101, 5287.973560132194, 5291.761870715817, 3944.073142811437, 4006.659433948118, 4084.9387259191135, 4103.712740108193, 4115.485564304462, 4092.529359123694, 4098.241825262321, 4106.8767936961785, 4111.095558977036, 4112.897177570555, 4056.5132184137947, 4060.4112403701447, 4068.125353049094, 4068.776217308047, 4069.125138095309, 3927.293087244295, 4010.8997275068064, 4098.139390727951, 4102.938455923164, 4103.958960410388, 3612.9277414451826, 3613.2231570212266, 3615.963840361589, 3618.8914332570066, 3625.274945010982, 5093.0577843099145, 5099.235114732783, 5104.974475127638, 5105.923411148836, 5111.182210846284, 4720.905581888343, 4722.3152642866935, 4725.905481890377, 4732.455767586737, 4736.739479328636, 5538.833834984957, 5541.639793413456, 5542.86142846428, 5543.307086614173, 5550.58370622205, 3951.269015232191, 3959.5644479107277, 3968.761874287523, 3975.7415767975276, 3976.443297938291, 5585.469380408855, 5838.2702162229725, 5847.8538036549, 5852.590318677694, 5861.267341582345, 3893.396523538856, 3930.8231129599235, 3934.449177115206, 3936.9212615747524, 3945.309570825094, 3990.980045099756, 3992.001999500125, 3996.1208534122447, 3996.580359062257, 3998.3202855514633, 4604.884877878013, 4611.76941152941, 4613.354130421743, 4619.584237418581, 4624.653151013687, 5562.833115006556, 5565.415631358649, 5573.247611572467, 5573.303337082864, 5574.749136288877, 1393.5401317565381, 1418.4751641892565, 1419.865112814281, 1420.552525954321, 1421.5380001499555, 882.5631312500353, 908.2370808520874, 922.5479515037583, 925.8564922437033, 949.4398305000083, 4860.343853579721, 4865.0756356292195, 4886.82896098642, 4894.290327902434, 4896.167651499253, 5695.715214239354, 5698.6580805151825, 5699.316082070178, 5700.173474846207, 5702.116171993348, 4870.732109733999, 4882.048000639841, 4882.096812089775, 4884.169691152512, 4890.315355850184, 3028.651705053903, 3057.2968217310145, 3063.433264846011, 3073.047355319858, 3075.8923437680023, 5379.919301210485, 5386.138217885198, 5390.730463476811, 5392.40683524812, 5396.4333744957, 5746.252987111732, 5850.151727999416, 5955.136505206808, 5972.46247837688, 5983.970080149571, 5478.0, 5492.890142197134, 5497.39528651856, 5497.532709719639, 5513.641613295123, 5829.854253643523, 5834.212381328636, 5836.153757705024, 5840.766369345179, 5843.386444423274, 5672.12082127271, 5684.0621297487105, 5685.459881311269, 5693.060644993529, 5695.800646977336, 5486.1222204447095, 5491.231227628055, 5494.642848214853, 5502.697351645698, 5504.972475137599, 3808.8095595219575, 3902.414637804352, 3926.9607303926596, 3931.5871833457077, 3935.685145188321, 5607.383187849415, 5638.23883775685, 5645.068563686946, 5650.745716442688, 5659.6321239119325, 5473.945260547503, 5474.233607294902, 5539.086050801734, 5575.609707320611, 5583.35791383996, 5562.0, 5564.081926482085, 5573.108302671553, 5574.303212098488, 5587.497125258747, 5489.917651235155, 5493.0, 5500.532454741392, 5501.477359650827, 5503.724813759216, 5451.100568406168, 5587.161925711176, 5604.103343465026, 5604.299462567179, 5613.410591887956, 5432.59255555827, 5461.5357694596405, 5464.890702186013, 5473.151661492475, 5486.588505861996], "unit": "score", "name": "prototype.html", "value": 4170.583997349902}, {"lowerIsBetter": false, "replicates": [675.6959368284273, 677.5663575311798, 704.8132244955087, 733.5048842031629, 755.6108604068905, 11342.092632589394, 11386.430678466075, 11434.771304573904, 11439.485223164957, 11594.826077608843, 11576.47905844237, 11705.882941170586, 11770.823437648422, 11848.348340841272, 11864.644060678173, 646.5991085526956, 660.6762686283711, 804.593680191504, 819.4223072733708, 819.737683941139, 787.629813987425, 816.9183081691842, 816.9468984515987, 817.2726273616486, 817.8732296494023, 837.6356285016037, 847.4068152293388, 848.2196379331031, 849.1975083546051, 849.9235068843802, 669.7823207457595, 804.1516200408566, 839.3495041342946, 845.8604330285496, 852.8209076094028, 618.6844709198341, 620.4694985787132, 621.0745988477137, 621.4313902778952, 623.3672822085587, 11158.66524004273, 11197.272177308449, 11203.551857925673, 11206.327620342723, 11216.943915280453, 11399.829002564968, 12476.937615311865, 12514.561990330385, 12654.683632909158, 12748.745025099539, 10131.341462804969, 10173.89826101737, 10232.488375581192, 10245.180385569136, 10280.12618927392, 3245.821479818609, 3274.3942370661503, 3287.3589650018257, 3335.34960682667, 3385.153711572107, 41793.373099403536, 41921.580784192374, 42033.789831050955, 42121.0, 42298.0, 9991.900080999098, 10029.548670309854, 10032.097111260022, 10199.490025498695, 10211.234157438223, 17622.911885440746, 17830.19764110618, 17851.553711157325, 17989.190486428142, 18041.458756237334, 6859.5541289816, 6949.617771022541, 6975.058367120475, 7001.404880585105, 7028.437724982092, 3681.447782832543, 3707.5180226570374, 3722.994791406305, 3753.7425707178463, 3761.39817629178, 2776.6390369251867, 2786.7909906757072, 2802.285417218637, 2807.284142543638, 2809.0870467098275, 485.52418629742346, 488.7043338780058, 495.2793685188043, 506.6301599832143, 548.3009163316723, 583.3787016827066, 583.4661284924332, 589.0780927847904, 589.2222266608036, 589.4282545930527, 8136.796580085427, 8347.4156809024, 8464.349451856951, 8544.48733076005, 8665.566721663892, 560.9579281553899, 595.0093094996869, 611.6849822341497, 616.6639181646013, 623.76297007137, 3691.187938653492, 3756.9436458453147, 3927.587603301612, 3937.625925537069, 4033.757974521538, 48372.27441588379, 48463.75768121137, 49402.75298623556, 49458.25812612814, 49586.50413495891, 42901.0, 43484.0, 43738.34392484115, 44002.55997440049, 45345.77327113343, 38740.41889371662, 39630.207395851925, 40594.391084133764, 40677.389839152434, 40834.18331633351, 7407.777766667009, 7657.961710191414, 7665.6550455228535, 7750.728724494616, 7850.685972561262, 30922.845385772926, 31429.0, 32013.199670007503, 32016.67983320137, 32019.839900800347, 37083.814580926926, 38405.423918640685, 40054.79972600118, 40249.798751006056, 40315.0, 9446.669366572138, 9451.196648284973, 9546.188573971012, 9581.808363832824, 9641.0, 10235.232357573062, 10241.231907607109, 10344.586216551254, 10447.843282350923, 10627.309224900357, 8457.619407126816, 10550.0, 10607.946960265457, 10613.893861061291, 10756.784864302514, 10369.0, 10417.687469375931, 10482.842757358798, 10511.159107271553, 10877.51051202682, 10176.949115254376, 10514.631987880388, 10965.232433729563, 11017.83473247918, 11123.27698699582, 9159.129882661136, 9312.301577381588, 9331.673391431268, 9417.905820941703, 9494.620215191315, 8790.912090879265, 8957.0, 9222.907770922206, 9266.490343031199, 9549.588028746151], "unit": "score", "name": "yui.html", "value": 5796.240072842881}], "name": "dromaeo_css", "value": 6287.364166004507}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 106.0, 112.0, 114.0, 113.0, 102.0, 114.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [168.0, 139.0, 155.0, 174.0, 138.0, 159.0, 156.0, 135.0, 184.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 160.0, 160.0, 160.0, 164.0, 162.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 108.0, 101.0, 73.0, 73.0, 75.0, 120.0, 108.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 146.0, 94.0, 94.0, 94.0, 140.0, 93.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 66.0, 65.0, 66.0, 66.0, 74.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.6}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 91.0, 92.0, 84.0, 84.0, 83.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [129.0, 122.0, 125.0, 117.0, 117.0, 124.0, 118.0, 119.0, 117.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [142.0, 132.0, 152.0, 153.0, 142.0, 133.0, 149.0, 144.0, 147.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1529.2999999999997}]} 22:20:00 INFO - Return code: 0 22:20:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:20:00 ERROR - # TBPL SUCCESS # 22:20:00 INFO - Running post-action listener: _resource_record_post_action 22:20:00 INFO - Running post-run listener: _resource_record_post_run 22:20:01 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 519626752; Read time: 212; Write time: 448592 22:20:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233226240; Read time: 0; Write time: 227012 22:20:01 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 12288; Write bytes: 286400512; Read time: 212; Write time: 221580 22:20:01 INFO - Running post-run listener: _upload_blobber_files 22:20:01 INFO - Blob upload gear active. 22:20:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:20:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:20:02 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:03 INFO - (blobuploader) - INFO - Done attempting. 22:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:04 INFO - (blobuploader) - INFO - Done attempting. 22:20:04 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:04 INFO - Return code: 0 22:20:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:20:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1718fe4a707a05b11bdfeaea407f0f9556e34d7f2403400c0b267e9dc6d55f9621faf6f460f8ac724467aa6dbb2d76307c27210dd6659755f2374362454fc718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5821271c5507de209e1ee53a64467bbcf3d6c30cbca8baf77a1c2023f323c73ac48a11c95bf98029db1727d4fbd2d8cd3b4a6774fa7c8ce0f53105cd587e1335"} 22:20:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:20:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:20:04 INFO - Contents: 22:20:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1718fe4a707a05b11bdfeaea407f0f9556e34d7f2403400c0b267e9dc6d55f9621faf6f460f8ac724467aa6dbb2d76307c27210dd6659755f2374362454fc718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5821271c5507de209e1ee53a64467bbcf3d6c30cbca8baf77a1c2023f323c73ac48a11c95bf98029db1727d4fbd2d8cd3b4a6774fa7c8ce0f53105cd587e1335"} 22:20:04 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:04 INFO - Copying logs to upload dir... 22:20:04 INFO - mkdir: /builds/slave/test/build/upload/logs 22:20:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.291050 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-04-06 22:20:03.787803) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 22:20:03.791104) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 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/1718fe4a707a05b11bdfeaea407f0f9556e34d7f2403400c0b267e9dc6d55f9621faf6f460f8ac724467aa6dbb2d76307c27210dd6659755f2374362454fc718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5821271c5507de209e1ee53a64467bbcf3d6c30cbca8baf77a1c2023f323c73ac48a11c95bf98029db1727d4fbd2d8cd3b4a6774fa7c8ce0f53105cd587e1335"} build_url:https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/d78UItdQSTmRXQT6hq-rMg/artifacts/public/build/firefox-48.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/1718fe4a707a05b11bdfeaea407f0f9556e34d7f2403400c0b267e9dc6d55f9621faf6f460f8ac724467aa6dbb2d76307c27210dd6659755f2374362454fc718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5821271c5507de209e1ee53a64467bbcf3d6c30cbca8baf77a1c2023f323c73ac48a11c95bf98029db1727d4fbd2d8cd3b4a6774fa7c8ce0f53105cd587e1335"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 22:20:03.816569) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 22:20:03.816970) ========= 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=8887e36bb8e381bfd44124ac000001a8-1459999471.914707-1596632832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 22:20:03.899975) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 22:20:03.900327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 22:20:03.900693) ========= ========= Total master_lag: 0.34 =========