builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1463591247.22 results: success (0) buildid: 20160518085840 builduid: b78dbb4849ce401ab5db6e4a7698e765 revision: 47b83c8478a06374aa9306122a778654b912f713 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.215528) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.216816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.217100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.233689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.233982) ========= 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=0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 10:07:27-- 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% 22.5M=0.001s 2016-05-18 10:07:28 (22.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.360292) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.360608) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018081 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.410531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:27.410887) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47b83c8478a06374aa9306122a778654b912f713 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 47b83c8478a06374aa9306122a778654b912f713 --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=0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 10:07:28,223 truncating revision to first 12 chars 2016-05-18 10:07:28,223 Setting DEBUG logging. 2016-05-18 10:07:28,223 attempt 1/10 2016-05-18 10:07:28,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47b83c8478a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 10:07:28,615 unpacking tar archive at: mozilla-central-47b83c8478a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:28.115967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:28.116339) ========= script_repo_revision: 47b83c8478a06374aa9306122a778654b912f713 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:28.116841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:28.117156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 10:07:28.127060) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-18 10:07:28.127395) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:29 INFO - MultiFileLogger online at 20160518 10:07:29 in /builds/slave/test 10:07:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:07:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:29 INFO - {'append_to_log': False, 10:07:29 INFO - 'base_work_dir': '/builds/slave/test', 10:07:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:07:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:29 INFO - 'branch': 'Firefox-Non-PGO', 10:07:29 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:29 INFO - 'config_files': ('talos/linux_config.py',), 10:07:29 INFO - 'default_actions': ('clobber', 10:07:29 INFO - 'read-buildbot-config', 10:07:29 INFO - 'download-and-extract', 10:07:29 INFO - 'populate-webroot', 10:07:29 INFO - 'create-virtualenv', 10:07:29 INFO - 'install', 10:07:29 INFO - 'run-tests'), 10:07:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:29 INFO - 'download_minidump_stackwalk': True, 10:07:29 INFO - 'download_symbols': 'ondemand', 10:07:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:29 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:29 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:29 INFO - 'installer_path': 'installer.exe', 10:07:29 INFO - 'log_level': 'info', 10:07:29 INFO - 'log_name': 'talos', 10:07:29 INFO - 'log_to_console': True, 10:07:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:29 INFO - 'opt_config_files': (), 10:07:29 INFO - 'pip_index': False, 10:07:29 INFO - 'sps_profile': False, 10:07:29 INFO - 'sps_profile_interval': 0, 10:07:29 INFO - 'suite': 'dromaeojs', 10:07:29 INFO - 'system_bits': '32', 10:07:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:29 INFO - 'title': 'talos-linux64-ix-058', 10:07:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:29 INFO - 'use_talos_json': True, 10:07:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:29 INFO - 'work_dir': 'build'} 10:07:29 INFO - ##### 10:07:29 INFO - ##### Running clobber step. 10:07:29 INFO - ##### 10:07:29 INFO - Running pre-action listener: _resource_record_pre_action 10:07:29 INFO - Running main action method: clobber 10:07:29 INFO - rmtree: /builds/slave/test/build 10:07:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:29 INFO - Running post-action listener: _resource_record_post_action 10:07:29 INFO - ##### 10:07:29 INFO - ##### Finished clobber step (success) 10:07:29 INFO - ##### 10:07:29 INFO - ##### 10:07:29 INFO - ##### Running read-buildbot-config step. 10:07:29 INFO - ##### 10:07:29 INFO - Running pre-action listener: _resource_record_pre_action 10:07:29 INFO - Running main action method: read_buildbot_config 10:07:29 INFO - Using buildbot properties: 10:07:29 INFO - { 10:07:29 INFO - "project": "", 10:07:29 INFO - "product": "firefox", 10:07:29 INFO - "script_repo_revision": "production", 10:07:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:07:29 INFO - "repository": "", 10:07:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:07:29 INFO - "buildid": "20160518085840", 10:07:29 INFO - "pgo_build": "False", 10:07:29 INFO - "basedir": "/builds/slave/test", 10:07:29 INFO - "buildnumber": 585, 10:07:29 INFO - "slavename": "talos-linux64-ix-058", 10:07:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:07:29 INFO - "platform": "ubuntu64_hw", 10:07:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:07:29 INFO - "branch": "mozilla-central", 10:07:29 INFO - "repo_path": "mozilla-central", 10:07:29 INFO - "revision": "47b83c8478a06374aa9306122a778654b912f713", 10:07:29 INFO - "stage_platform": "linux64", 10:07:29 INFO - "builduid": "b78dbb4849ce401ab5db6e4a7698e765", 10:07:29 INFO - "slavebuilddir": "test" 10:07:29 INFO - } 10:07:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:07:29 INFO - Running post-action listener: _resource_record_post_action 10:07:29 INFO - ##### 10:07:29 INFO - ##### Finished read-buildbot-config step (success) 10:07:29 INFO - ##### 10:07:29 INFO - ##### 10:07:29 INFO - ##### Running download-and-extract step. 10:07:29 INFO - ##### 10:07:29 INFO - Running pre-action listener: _resource_record_pre_action 10:07:29 INFO - Running main action method: download_and_extract 10:07:29 INFO - mkdir: /builds/slave/test/build/tests 10:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:29 INFO - https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:07:30 INFO - Downloaded 1361 bytes. 10:07:30 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:07:30 INFO - Using the following test package requirements: 10:07:30 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:30 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:30 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:07:30 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:30 INFO - u'jsshell-linux-x86_64.zip'], 10:07:30 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:30 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:30 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:30 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:30 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:30 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:30 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:30 INFO - https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:31 INFO - Downloaded 22489086 bytes. 10:07:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:32 INFO - Return code: 0 10:07:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:07: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')]} 10:07:32 INFO - https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:07:33 INFO - Downloaded 22489086 bytes. 10:07:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:35 INFO - Return code: 0 10:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:35 INFO - https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:07:36 INFO - Downloaded 10840194 bytes. 10:07:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:07:36 INFO - Return code: 0 10:07: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')]} 10:07:36 INFO - https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:07:41 INFO - Downloaded 54774530 bytes. 10:07:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:41 INFO - mkdir: /builds/slave/test/properties 10:07:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:41 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:41 INFO - Contents: 10:07:41 INFO - build_url:https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:07:42 INFO - Running post-action listener: _resource_record_post_action 10:07:42 INFO - Running post-action listener: set_extra_try_arguments 10:07:42 INFO - ##### 10:07:42 INFO - ##### Finished download-and-extract step (success) 10:07:42 INFO - ##### 10:07:42 INFO - ##### 10:07:42 INFO - ##### Running populate-webroot step. 10:07:42 INFO - ##### 10:07:42 INFO - Running pre-action listener: _resource_record_pre_action 10:07:42 INFO - Running main action method: populate_webroot 10:07:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:42 INFO - '--tppagecycles', 10:07:42 INFO - '7'], 10:07:42 INFO - 'tests': ['tsvgm']}}, 10:07:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:42 INFO - 'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:42 INFO - 'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['damp', 'tps']}, 10:07:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:42 INFO - 'tests': ['damp', 'tps']}, 10:07:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['dromaeo_dom']}, 10:07:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['a11yr', 10:07:42 INFO - 'ts_paint', 10:07:42 INFO - 'tpaint', 10:07:42 INFO - 'sessionrestore', 10:07:42 INFO - 'sessionrestore_no_auto_restore', 10:07:42 INFO - 'tabpaint']}, 10:07:42 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:42 INFO - 'ts_paint', 10:07:42 INFO - 'tpaint', 10:07:42 INFO - 'sessionrestore', 10:07:42 INFO - 'sessionrestore_no_auto_restore', 10:07:42 INFO - 'tabpaint']}, 10:07:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:42 INFO - 'ts_paint', 10:07:42 INFO - 'tpaint', 10:07:42 INFO - 'sessionrestore', 10:07:42 INFO - 'sessionrestore_no_auto_restore', 10:07:42 INFO - 'tabpaint']}, 10:07:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:42 INFO - 'ts_paint', 10:07:42 INFO - 'tpaint', 10:07:42 INFO - 'sessionrestore', 10:07:42 INFO - 'sessionrestore_no_auto_restore', 10:07:42 INFO - 'tabpaint']}, 10:07:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['a11yr', 10:07:42 INFO - 'ts_paint', 10:07:42 INFO - 'tpaint', 10:07:42 INFO - 'sessionrestore', 10:07:42 INFO - 'sessionrestore_no_auto_restore', 10:07:42 INFO - 'tabpaint']}, 10:07:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['a11yr', 10:07:42 INFO - 'ts_paint', 10:07:42 INFO - 'tpaint', 10:07:42 INFO - 'sessionrestore', 10:07:42 INFO - 'sessionrestore_no_auto_restore', 10:07:42 INFO - 'tabpaint']}, 10:07:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['tsvgx', 10:07:42 INFO - 'tsvgr_opacity', 10:07:42 INFO - 'tart', 10:07:42 INFO - 'tscrollx', 10:07:42 INFO - 'cart']}, 10:07:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:42 INFO - 'tsvgr_opacity', 10:07:42 INFO - 'tart', 10:07:42 INFO - 'tscrollx', 10:07:42 INFO - 'cart']}, 10:07:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:42 INFO - 'talos_options': ['--disable-e10s'], 10:07:42 INFO - 'tests': ['tp5o']}, 10:07:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:42 INFO - 'tests': ['tp5o']}, 10:07:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:42 INFO - 'talos_options': ['--disable-e10s', 10:07:42 INFO - '--xperf_path', 10:07:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:42 INFO - 'tests': ['tp5n']}, 10:07:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:42 INFO - 'talos_options': ['--xperf_path', 10:07:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:42 INFO - 'tests': ['tp5n']}}, 10:07:42 INFO - 'talos.zip': {'path': '', 10:07:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:42 INFO - Running post-action listener: _resource_record_post_action 10:07:42 INFO - ##### 10:07:42 INFO - ##### Finished populate-webroot step (success) 10:07:42 INFO - ##### 10:07:42 INFO - ##### 10:07:42 INFO - ##### Running create-virtualenv step. 10:07:42 INFO - ##### 10:07:42 INFO - Running pre-action listener: _resource_record_pre_action 10:07:42 INFO - Running main action method: create_virtualenv 10:07:42 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:42 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 10:07:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:42 INFO - Using real prefix '/usr' 10:07:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:43 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:45 INFO - Installing pip.................done. 10:07:45 INFO - Return code: 0 10:07:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 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 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:07:45 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 10:07:45 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 10:07:45 INFO - Using env: {'DISPLAY': ':0', 10:07:45 INFO - 'HOME': '/home/cltbld', 10:07:45 INFO - 'LANG': 'en_US.UTF-8', 10:07:45 INFO - 'LANGUAGE': 'en_US:en', 10:07:45 INFO - 'LOGNAME': 'cltbld', 10:07:45 INFO - 'MAIL': '/var/mail/cltbld', 10:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:45 INFO - 'MOZ_NO_REMOTE': '1', 10:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:45 INFO - 'NO_EM_RESTART': '1', 10:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:45 INFO - 'PWD': '/builds/slave/test', 10:07:45 INFO - 'SHELL': '/bin/bash', 10:07:45 INFO - 'SHLVL': '1', 10:07:45 INFO - 'TERM': 'linux', 10:07:45 INFO - 'TMOUT': '86400', 10:07:45 INFO - 'USER': 'cltbld', 10:07:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:45 INFO - '_': '/tools/buildbot/bin/python'} 10:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:45 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 10:07:45 INFO - Cleaning up... 10:07:45 INFO - Return code: 0 10:07:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:07:45 INFO - Using env: {'DISPLAY': ':0', 10:07:45 INFO - 'HOME': '/home/cltbld', 10:07:45 INFO - 'LANG': 'en_US.UTF-8', 10:07:45 INFO - 'LANGUAGE': 'en_US:en', 10:07:45 INFO - 'LOGNAME': 'cltbld', 10:07:45 INFO - 'MAIL': '/var/mail/cltbld', 10:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:45 INFO - 'MOZ_NO_REMOTE': '1', 10:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:45 INFO - 'NO_EM_RESTART': '1', 10:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:45 INFO - 'PWD': '/builds/slave/test', 10:07:45 INFO - 'SHELL': '/bin/bash', 10:07:45 INFO - 'SHLVL': '1', 10:07:45 INFO - 'TERM': 'linux', 10:07:45 INFO - 'TMOUT': '86400', 10:07:45 INFO - 'USER': 'cltbld', 10:07:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:45 INFO - '_': '/tools/buildbot/bin/python'} 10:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:45 INFO - Downloading/unpacking psutil>=3.1.1 10:07:45 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 10:07:45 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 10:07:45 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 10:07:45 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 10:07:45 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 10:07:45 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 10:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:48 INFO - Installing collected packages: psutil 10:07:48 INFO - Running setup.py install for psutil 10:07:49 INFO - building 'psutil._psutil_linux' extension 10:07:49 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 10:07:49 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 10:07:49 INFO - building 'psutil._psutil_posix' extension 10:07:49 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 10:07:49 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 10:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:49 INFO - Successfully installed psutil 10:07:49 INFO - Cleaning up... 10:07:49 INFO - Return code: 0 10:07:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:07:49 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')]} 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:49 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')]} 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:07:49 INFO - Using env: {'DISPLAY': ':0', 10:07:49 INFO - 'HOME': '/home/cltbld', 10:07:49 INFO - 'LANG': 'en_US.UTF-8', 10:07:49 INFO - 'LANGUAGE': 'en_US:en', 10:07:49 INFO - 'LOGNAME': 'cltbld', 10:07:49 INFO - 'MAIL': '/var/mail/cltbld', 10:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:49 INFO - 'MOZ_NO_REMOTE': '1', 10:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:49 INFO - 'NO_EM_RESTART': '1', 10:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:49 INFO - 'PWD': '/builds/slave/test', 10:07:49 INFO - 'SHELL': '/bin/bash', 10:07:49 INFO - 'SHLVL': '1', 10:07:49 INFO - 'TERM': 'linux', 10:07:49 INFO - 'TMOUT': '86400', 10:07:49 INFO - 'USER': 'cltbld', 10:07:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:49 INFO - '_': '/tools/buildbot/bin/python'} 10:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:07:49 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 10:07:49 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 10:07:49 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 10:07:49 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 10:07:49 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 10:07:49 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 10:07:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:07:52 INFO - Installing collected packages: mozsystemmonitor 10:07:52 INFO - Running setup.py install for mozsystemmonitor 10:07:52 INFO - Successfully installed mozsystemmonitor 10:07:52 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:07:52 INFO - Using env: {'DISPLAY': ':0', 10:07:52 INFO - 'HOME': '/home/cltbld', 10:07:52 INFO - 'LANG': 'en_US.UTF-8', 10:07:52 INFO - 'LANGUAGE': 'en_US:en', 10:07:52 INFO - 'LOGNAME': 'cltbld', 10:07:52 INFO - 'MAIL': '/var/mail/cltbld', 10:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:52 INFO - 'MOZ_NO_REMOTE': '1', 10:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:52 INFO - 'NO_EM_RESTART': '1', 10:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:52 INFO - 'PWD': '/builds/slave/test', 10:07:52 INFO - 'SHELL': '/bin/bash', 10:07:52 INFO - 'SHLVL': '1', 10:07:52 INFO - 'TERM': 'linux', 10:07:52 INFO - 'TMOUT': '86400', 10:07:52 INFO - 'USER': 'cltbld', 10:07:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:52 INFO - '_': '/tools/buildbot/bin/python'} 10:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:52 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:58 INFO - Downloading docopt-0.6.1.tar.gz 10:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:58 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:58 INFO - Running setup.py install for blobuploader 10:07:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:58 INFO - Running setup.py install for requests 10:07:59 INFO - Running setup.py install for docopt 10:07:59 INFO - Successfully installed blobuploader requests docopt 10:07:59 INFO - Cleaning up... 10:07:59 INFO - Return code: 0 10:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07: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')]} 10:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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')]} 10:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:59 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 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:07:59 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 10:07:59 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 10:07:59 INFO - Using env: {'DISPLAY': ':0', 10:07:59 INFO - 'HOME': '/home/cltbld', 10:07:59 INFO - 'LANG': 'en_US.UTF-8', 10:07:59 INFO - 'LANGUAGE': 'en_US:en', 10:07:59 INFO - 'LOGNAME': 'cltbld', 10:07:59 INFO - 'MAIL': '/var/mail/cltbld', 10:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:59 INFO - 'MOZ_NO_REMOTE': '1', 10:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:59 INFO - 'NO_EM_RESTART': '1', 10:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:59 INFO - 'PWD': '/builds/slave/test', 10:07:59 INFO - 'SHELL': '/bin/bash', 10:07:59 INFO - 'SHLVL': '1', 10:07:59 INFO - 'TERM': 'linux', 10:07:59 INFO - 'TMOUT': '86400', 10:07:59 INFO - 'USER': 'cltbld', 10:07:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:59 INFO - '_': '/tools/buildbot/bin/python'} 10:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:59 INFO - Running setup.py (path:/tmp/pip-LCp8ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:59 INFO - Running setup.py (path:/tmp/pip-b8uejN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:59 INFO - Running setup.py (path:/tmp/pip-snHonp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:59 INFO - Running setup.py (path:/tmp/pip-ZgEkxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:59 INFO - Running setup.py (path:/tmp/pip-Qd87BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:59 INFO - Running setup.py (path:/tmp/pip-FCU1Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:59 INFO - Running setup.py (path:/tmp/pip-YK0KmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:59 INFO - Running setup.py (path:/tmp/pip-gN9Wn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:59 INFO - Running setup.py (path:/tmp/pip-jCJfkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:00 INFO - Running setup.py (path:/tmp/pip-l5CoCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:00 INFO - Running setup.py (path:/tmp/pip-SIrjTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:00 INFO - Running setup.py (path:/tmp/pip-6kqyBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:00 INFO - Running setup.py (path:/tmp/pip-6Sofgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:00 INFO - Running setup.py (path:/tmp/pip-czXmL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:00 INFO - Running setup.py (path:/tmp/pip-4PfUYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:00 INFO - Running setup.py (path:/tmp/pip-NxyDbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:00 INFO - Running setup.py (path:/tmp/pip-AhDFNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:00 INFO - Running setup.py install for manifestparser 10:08:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozcrash 10:08:00 INFO - Running setup.py install for mozdebug 10:08:00 INFO - Running setup.py install for mozdevice 10:08:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for mozfile 10:08:01 INFO - Running setup.py install for mozhttpd 10:08:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for mozinfo 10:08:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for mozInstall 10:08:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for mozleak 10:08:01 INFO - Running setup.py install for mozlog 10:08:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for moznetwork 10:08:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for mozprocess 10:08:01 INFO - Running setup.py install for mozprofile 10:08:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for mozrunner 10:08:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:02 INFO - Running setup.py install for mozscreenshot 10:08:02 INFO - Running setup.py install for moztest 10:08:02 INFO - Running setup.py install for mozversion 10:08:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:02 INFO - Cleaning up... 10:08:02 INFO - Return code: 0 10:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:02 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')]} 10:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:02 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')]} 10:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:02 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 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:08:02 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 10:08:02 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 10:08:02 INFO - Using env: {'DISPLAY': ':0', 10:08:02 INFO - 'HOME': '/home/cltbld', 10:08:02 INFO - 'LANG': 'en_US.UTF-8', 10:08:02 INFO - 'LANGUAGE': 'en_US:en', 10:08:02 INFO - 'LOGNAME': 'cltbld', 10:08:02 INFO - 'MAIL': '/var/mail/cltbld', 10:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:02 INFO - 'MOZ_NO_REMOTE': '1', 10:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:02 INFO - 'NO_EM_RESTART': '1', 10:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:02 INFO - 'PWD': '/builds/slave/test', 10:08:02 INFO - 'SHELL': '/bin/bash', 10:08:02 INFO - 'SHLVL': '1', 10:08:02 INFO - 'TERM': 'linux', 10:08:02 INFO - 'TMOUT': '86400', 10:08:02 INFO - 'USER': 'cltbld', 10:08:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:02 INFO - '_': '/tools/buildbot/bin/python'} 10:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:02 INFO - Running setup.py (path:/tmp/pip-lPtKN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:02 INFO - Running setup.py (path:/tmp/pip-rSThlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:02 INFO - Running setup.py (path:/tmp/pip-vWl9xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:02 INFO - Running setup.py (path:/tmp/pip-HOZYvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:02 INFO - Running setup.py (path:/tmp/pip-w4mba6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:02 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)) 10:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:03 INFO - Running setup.py (path:/tmp/pip-dcTr0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:03 INFO - Running setup.py (path:/tmp/pip-xmeNvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:03 INFO - Running setup.py (path:/tmp/pip-EEwL2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:03 INFO - Running setup.py (path:/tmp/pip-zNRquK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:03 INFO - Running setup.py (path:/tmp/pip-JQEerT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:03 INFO - Running setup.py (path:/tmp/pip-P9Q1X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:03 INFO - Running setup.py (path:/tmp/pip-dsqY6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:03 INFO - Running setup.py (path:/tmp/pip-yIaOXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:03 INFO - Running setup.py (path:/tmp/pip-QzEzOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:03 INFO - Running setup.py (path:/tmp/pip-yE_l1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:03 INFO - Running setup.py (path:/tmp/pip-XpM_c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:03 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)) 10:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:03 INFO - Running setup.py (path:/tmp/pip-NcRIzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:03 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)) 10:08:03 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)) 10:08:03 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)) 10:08:03 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)) 10:08:03 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)) 10:08:03 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)) 10:08:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:06 INFO - Downloading blessings-1.6.tar.gz 10:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:06 INFO - Installing collected packages: blessings 10:08:06 INFO - Running setup.py install for blessings 10:08:06 INFO - Successfully installed blessings 10:08:06 INFO - Cleaning up... 10:08:07 INFO - Return code: 0 10:08:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:07 INFO - Reading from file tmpfile_stdout 10:08:07 INFO - Current package versions: 10:08:07 INFO - argparse == 1.2.1 10:08:07 INFO - blessings == 1.6 10:08:07 INFO - blobuploader == 1.2.4 10:08:07 INFO - docopt == 0.6.1 10:08:07 INFO - manifestparser == 1.1 10:08:07 INFO - mozInstall == 1.12 10:08:07 INFO - mozcrash == 0.17 10:08:07 INFO - mozdebug == 0.1 10:08:07 INFO - mozdevice == 0.48 10:08:07 INFO - mozfile == 1.2 10:08:07 INFO - mozhttpd == 0.7 10:08:07 INFO - mozinfo == 0.9 10:08:07 INFO - mozleak == 0.1 10:08:07 INFO - mozlog == 3.2 10:08:07 INFO - moznetwork == 0.27 10:08:07 INFO - mozprocess == 0.22 10:08:07 INFO - mozprofile == 0.28 10:08:07 INFO - mozrunner == 6.11 10:08:07 INFO - mozscreenshot == 0.1 10:08:07 INFO - mozsystemmonitor == 0.3 10:08:07 INFO - moztest == 0.7 10:08:07 INFO - mozversion == 1.4 10:08:07 INFO - psutil == 3.1.1 10:08:07 INFO - requests == 1.2.3 10:08:07 INFO - wsgiref == 0.1.2 10:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:07 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')]} 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 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')]} 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 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 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:08:07 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 10:08:07 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 10:08:07 INFO - Using env: {'DISPLAY': ':0', 10:08:07 INFO - 'HOME': '/home/cltbld', 10:08:07 INFO - 'LANG': 'en_US.UTF-8', 10:08:07 INFO - 'LANGUAGE': 'en_US:en', 10:08:07 INFO - 'LOGNAME': 'cltbld', 10:08:07 INFO - 'MAIL': '/var/mail/cltbld', 10:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:07 INFO - 'MOZ_NO_REMOTE': '1', 10:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:07 INFO - 'NO_EM_RESTART': '1', 10:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:07 INFO - 'PWD': '/builds/slave/test', 10:08:07 INFO - 'SHELL': '/bin/bash', 10:08:07 INFO - 'SHLVL': '1', 10:08:07 INFO - 'TERM': 'linux', 10:08:07 INFO - 'TMOUT': '86400', 10:08:07 INFO - 'USER': 'cltbld', 10:08:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:07 INFO - '_': '/tools/buildbot/bin/python'} 10:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 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)) 10:08:07 INFO - Cleaning up... 10:08:07 INFO - Return code: 0 10:08:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08:07 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')]} 10:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 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')]} 10:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:07 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 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:08:07 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 10:08:07 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 10:08:07 INFO - Using env: {'DISPLAY': ':0', 10:08:07 INFO - 'HOME': '/home/cltbld', 10:08:07 INFO - 'LANG': 'en_US.UTF-8', 10:08:07 INFO - 'LANGUAGE': 'en_US:en', 10:08:07 INFO - 'LOGNAME': 'cltbld', 10:08:07 INFO - 'MAIL': '/var/mail/cltbld', 10:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:07 INFO - 'MOZ_NO_REMOTE': '1', 10:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:07 INFO - 'NO_EM_RESTART': '1', 10:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:07 INFO - 'PWD': '/builds/slave/test', 10:08:07 INFO - 'SHELL': '/bin/bash', 10:08:07 INFO - 'SHLVL': '1', 10:08:07 INFO - 'TERM': 'linux', 10:08:07 INFO - 'TMOUT': '86400', 10:08:07 INFO - 'USER': 'cltbld', 10:08:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:07 INFO - '_': '/tools/buildbot/bin/python'} 10:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:07 INFO - Downloading/unpacking jsonschema 10:08:07 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 10:08:07 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 10:08:07 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 10:08:07 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 10:08:07 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 10:08:07 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 10:08:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:10 INFO - Downloading/unpacking functools32 (from jsonschema) 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:10 INFO - warning: no files found matching '*.txt' 10:08:10 INFO - no previously-included directories found matching 'build' 10:08:10 INFO - no previously-included directories found matching 'dist' 10:08:10 INFO - no previously-included directories found matching '.git*' 10:08:10 INFO - Installing collected packages: jsonschema, functools32 10:08:10 INFO - Running setup.py install for functools32 10:08:10 INFO - warning: no files found matching '*.txt' 10:08:10 INFO - no previously-included directories found matching 'build' 10:08:10 INFO - no previously-included directories found matching 'dist' 10:08:10 INFO - no previously-included directories found matching '.git*' 10:08:10 INFO - Successfully installed jsonschema functools32 10:08:10 INFO - Cleaning up... 10:08:10 INFO - Return code: 0 10:08:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:08:10 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')]} 10:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:10 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')]} 10:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:10 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 0x7f65beb57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd55770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, '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': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', '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 10:08:10 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 10:08:10 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 10:08:10 INFO - Using env: {'DISPLAY': ':0', 10:08:10 INFO - 'HOME': '/home/cltbld', 10:08:10 INFO - 'LANG': 'en_US.UTF-8', 10:08:10 INFO - 'LANGUAGE': 'en_US:en', 10:08:10 INFO - 'LOGNAME': 'cltbld', 10:08:10 INFO - 'MAIL': '/var/mail/cltbld', 10:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:10 INFO - 'MOZ_NO_REMOTE': '1', 10:08:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:10 INFO - 'NO_EM_RESTART': '1', 10:08:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:10 INFO - 'PWD': '/builds/slave/test', 10:08:10 INFO - 'SHELL': '/bin/bash', 10:08:10 INFO - 'SHLVL': '1', 10:08:10 INFO - 'TERM': 'linux', 10:08:10 INFO - 'TMOUT': '86400', 10:08:10 INFO - 'USER': 'cltbld', 10:08:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:10 INFO - '_': '/tools/buildbot/bin/python'} 10:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:10 INFO - Downloading/unpacking flake8 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:10 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 10:08:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:08:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:08:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:12 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 10:08:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:08:13 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 10:08:13 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 10:08:13 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 10:08:13 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 10:08:13 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 10:08:13 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 10:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:08:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:13 INFO - no previously-included directories found matching 'docs/_build' 10:08:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:08:13 INFO - Running setup.py install for pep8 10:08:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:08:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:08:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:08:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:08:13 INFO - no previously-included directories found matching 'docs/_build' 10:08:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:08:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:08:13 INFO - Cleaning up... 10:08:13 INFO - Return code: 0 10:08:13 INFO - Running post-action listener: _resource_record_post_action 10:08:13 INFO - Running post-action listener: _start_resource_monitoring 10:08:13 INFO - Starting resource monitoring. 10:08:13 INFO - ##### 10:08:13 INFO - ##### Finished create-virtualenv step (success) 10:08:13 INFO - ##### 10:08:13 INFO - ##### 10:08:13 INFO - ##### Running install step. 10:08:13 INFO - ##### 10:08:13 INFO - Running pre-action listener: _resource_record_pre_action 10:08:13 INFO - Running main action method: install 10:08:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:13 INFO - Reading from file tmpfile_stdout 10:08:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:14 INFO - Reading from file tmpfile_stdout 10:08:14 INFO - Output received: 10:08:14 INFO - Usage: mozinstall [options] installer 10:08:14 INFO - Options: 10:08:14 INFO - -h, --help show this help message and exit 10:08:14 INFO - -d DEST, --destination=DEST 10:08:14 INFO - Directory to install application into. [default: 10:08:14 INFO - "/builds/slave/test"] 10:08:14 INFO - --app=APP Application being installed. [default: firefox] 10:08:14 INFO - mkdir: /builds/slave/test/build/application 10:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:08:29 INFO - Reading from file tmpfile_stdout 10:08:29 INFO - Output received: 10:08:29 INFO - /builds/slave/test/build/application/firefox/firefox 10:08:29 INFO - Running post-action listener: _resource_record_post_action 10:08:29 INFO - ##### 10:08:29 INFO - ##### Finished install step (success) 10:08:29 INFO - ##### 10:08:29 INFO - ##### 10:08:29 INFO - ##### Running run-tests step. 10:08:29 INFO - ##### 10:08:29 INFO - Running pre-action listener: _resource_record_pre_action 10:08:29 INFO - Running main action method: run_tests 10:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:29 INFO - Python 2.7.3 10:08:29 INFO - Return code: 0 10:08:29 INFO - grabbing minidump binary from tooltool 10:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde49c0>, '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 0xde58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:29 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 10:08:29 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 10:08:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:08:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:29 INFO - Return code: 0 10:08:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:08:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:08:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:08:30 INFO - Return code: 0 10:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 10:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 10:08:30 INFO - Using env: {'DISPLAY': ':0', 10:08:30 INFO - 'HOME': '/home/cltbld', 10:08:30 INFO - 'LANG': 'en_US.UTF-8', 10:08:30 INFO - 'LANGUAGE': 'en_US:en', 10:08:30 INFO - 'LOGNAME': 'cltbld', 10:08:30 INFO - 'MAIL': '/var/mail/cltbld', 10:08:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:30 INFO - 'MOZ_NO_REMOTE': '1', 10:08:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:30 INFO - 'NO_EM_RESTART': '1', 10:08:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:30 INFO - 'PWD': '/builds/slave/test', 10:08:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:30 INFO - 'SHELL': '/bin/bash', 10:08:30 INFO - 'SHLVL': '1', 10:08:30 INFO - 'TERM': 'linux', 10:08:30 INFO - 'TMOUT': '86400', 10:08:30 INFO - 'USER': 'cltbld', 10:08:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891', 10:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:30 INFO - '_': '/tools/buildbot/bin/python'} 10:08:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 10:08:31 INFO - mozversion application_buildid: 20160518085840 10:08:31 INFO - mozversion application_changeset: 47b83c8478a06374aa9306122a778654b912f713 10:08:31 INFO - mozversion application_display_name: Nightly 10:08:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:31 INFO - mozversion application_name: Firefox 10:08:31 INFO - mozversion application_remotingname: firefox 10:08:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:08:31 INFO - mozversion application_vendor: Mozilla 10:08:31 INFO - mozversion application_version: 49.0a1 10:08:31 INFO - mozversion platform_buildid: 20160518085840 10:08:31 INFO - mozversion platform_changeset: 47b83c8478a06374aa9306122a778654b912f713 10:08:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:08:31 INFO - mozversion platform_version: 49.0a1 10:08:31 INFO - using testdate: 1463591311 10:08:31 INFO - actual date: 1463591311 10:08:31 INFO - starting webserver on 'localhost:37419' 10:08:31 INFO - SUITE-START | Running 2 tests 10:08:31 INFO - TEST-START | dromaeo_css 10:08:31 INFO - operating with platform_type : linux_ 10:08:31 INFO - Initialising browser for dromaeo_css test... 10:08:31 INFO - TEST-INFO | started process 6432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV98uwv/profile http://localhost:37419/getInfo.html) 10:08:35 INFO - PROCESS | 6432 | __metrics Screen width/height:1600/1200 10:08:35 INFO - PROCESS | 6432 | colorDepth:24 10:08:35 INFO - PROCESS | 6432 | Browser inner width/height: 1024/697 10:08:35 INFO - PROCESS | 6432 | __metrics 10:08:36 ERROR - PROCESS | 6432 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:08:37 INFO - TEST-INFO | 6432: exit 0 10:08:37 INFO - Browser initialized. 10:08:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:37 INFO - TEST-INFO | started process 6514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV98uwv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:49 INFO - PROCESS | 6514 | RSS: Main: 154996736 10:08:49 INFO - PROCESS | 6514 | 10:09:40 INFO - PROCESS | 6514 | 1463591380229 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] 10:11:53 INFO - PROCESS | 6514 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37419/tests/dromaeo/cssquery-ext.html) 10:11:54 INFO - PROCESS | 6514 | RSS: Main: 266289152 10:11:54 INFO - PROCESS | 6514 | 10:14:56 INFO - PROCESS | 6514 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-ext.html (next: http://localhost:37419/tests/dromaeo/cssquery-jquery.html) 10:14:57 INFO - PROCESS | 6514 | RSS: Main: 240693248 10:14:57 INFO - PROCESS | 6514 | 10:17:59 INFO - PROCESS | 6514 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37419/tests/dromaeo/cssquery-mootools.html) 10:18:00 INFO - PROCESS | 6514 | RSS: Main: 238026752 10:18:00 INFO - PROCESS | 6514 | 10:21:02 INFO - PROCESS | 6514 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37419/tests/dromaeo/cssquery-prototype.html) 10:21:02 INFO - PROCESS | 6514 | RSS: Main: 234422272 10:21:02 INFO - PROCESS | 6514 | 10:24:05 INFO - PROCESS | 6514 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37419/tests/dromaeo/cssquery-yui.html) 10:24:06 INFO - PROCESS | 6514 | RSS: Main: 221282304 10:24:06 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | Cycle 1(1): loaded http://localhost:37419/tests/dromaeo/cssquery-yui.html (next: http://localhost:37419/tests/dromaeo/cssquery-dojo.html) 10:27:09 INFO - PROCESS | 6514 | RSS: Main: 271368192 10:27:09 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | __start_tp_report 10:27:09 INFO - PROCESS | 6514 | _x_x_mozilla_page_load 10:27:09 INFO - PROCESS | 6514 | _x_x_mozilla_page_load_details 10:27:09 INFO - PROCESS | 6514 | |i|pagename|runs| 10:27:09 INFO - PROCESS | 6514 | |0;dojo.html;2662.4675064987;2686.570148776196;2713.9592906106404;2714.742099500548;2728.6043523689063;4704.4589872164715;4745.311929770181;4760.809567617292;4809.158397280479;4839.685420447673;4740.288956656504;4767.0942520921;4777.187878060729;4782.258749893764;4804.5916097131785;4337.934930976038;4401.383806267125;4446.266366049598;4479.462464504248;4575.039241759235;4470.530594287618;4493.033997690496;4520.412346394964;4527.16247494213;4541.931871021938;4306.397104405386;4336.176126535948;4342.370356298351;4374.803133858984;4381.605655490989;4352.630026447724;4358.65130789536;4361.193179261815;4402.471703395581;4438.711483753578;4408.669349798778;4418.7790610469665;4419.690621656486;4423.712458690175;4461.330800379937;4561.224591819366;4701.0127873146685;4727.5272472752795;4751.738654374008;4800.903981920377;5127.564157046656;5170.043541944752;5200;5204.29741984831;5205.765740541647;5150.0472412603785;5243.659162154448;5246.265522826808;5246.422893481752;5247.029299579552;4662.8368007119925;4762.64280178988;4794.520547945178;4797.856064318076;4871.2206047032305;5297.54970827484;5301.443348448357;5310.283111779938;5348.5186333230195;5351.9464805351445;5065.721385323769;5115.7953681852305;5120.718360490208;5121.385433747974;5123.641345105807;5023.045621331935;5096.184610462308;5113.821016264413;5126.948975460022;5162.380514338229;5103.755481093356;5110.48895110486;5112.718800465936;5121.052605268037;5122.615803814729;5110.616703747234;5112.130937740593;5112.821051263262;5117.71852548106;5150.922736158961;4237.406763053175;4265.786710664454;4266.786660666954;4271.337942618899;4297.634701050446;3753.718471114623;3759.9248015039548;3785.3186426442953;3799.0882188274613;3815.923681526354;4436.179306828247;4450.599446049871;4455.309427038814;4497.415336006364;4498.212812757754;5040.092783299041;5145.665531740425;5147.970405918832;5158.458361872024;5216.869578260498;4453.487848897418;4467.508574056851;4474.7762611869275;4497.987952710614;4513.323001549794;4636.466806317249;4650.488446270908;4665.883352916137;4668.11305851887;4718.622510199176;4740.644451666208;4829.903401932012;4867.926981095357;4874.53691899269;4924.926126108111;5070.264811602223;5090.211017292326;5098.209777484496;5150.768215430239;5165.66423182492;4824.589909857561;4848.951510484992;4856.902861942812;4857.101436234308;4887.266909963391;4861.95138048615;4950.579200767975;4999.750012499433;5046.495350465071;5078.390593128848;5143.92284115746;5177.585793136615;5185.274061631299;5189.506996835295;5237.947620523899;4836.588889944253;5005.424376196784;5026.145555255543;5027;5028.321176641253;4958.528939750718;4975.0547395994645;5005.299258103795;5011.148104822262;5048.3941926969;4956.826511072095;4959.156943319572;5003.674761140514;5013.774380152829;5015.398152221756;4931.260310953386;5007.524285192901;5087.389513258433;5087.771050302671;5125.359330083739;4927.827526036572;4953.628477864103;4974.0797952378925;4986.675866068694;5031.371078615173 10:27:09 INFO - PROCESS | 6514 | |1;ext.html;549.299642955232;595.8421018430115;601.5548494114357;603.3815339277243;604.8971674815281;41387.99999999996;42696.57303426965;42888.78555607225;42901.78549107254;46879;42421.15157696844;42441.15117697644;43057.35413968793;43246.13507729844;43253.35119973195;7477.401807855385;7929.6828126875;8032.1566235545015;8075.192480751907;9886.456244906527;9894.158996485272;10279.691609251697;10287.79424411515;10298.12465940396;10303.53634086464;10308.845367319496;10340.121089707383;10343.844842327371;10346.120579750692;10372.273940824145;7656.502327348732;7854.842903141962;7856.332211762007;9903.801923961553;10192.898071019306;9784.217262618973;10136.89863101367;10137.949310253402;10140.239482038876;10153.4923253837;39699.40450893239;39961.600383996076;39982.60017399818;40000.19999600021;40133.397999030036;3103.3638104188585;3124.297033167542;3127.9218019549467;3213.453712868818;3395.8641654333796;29609;29974.55038174429;30046;30078.156152803393;30181;3425.520427140202;3498.6851183393364;3528.558930133733;3549;3573.6069032406413;259907;262100;264534;264608;264622;33235.66764332326;49998.250131240304;50081;50122.498775012515;50250.74874625603;33238.66761332404;35373.46939795905;35401.291974160886;35477.29045419077;35489;11471.770564588662;11540.538378464935;11604.6518604442;11652.592159274385;11656.766864662828;9400.95299523498;9461;9664.468454235084;9695.078967498077;10045.146162576262;8169.183081691784;8178.100408955011;8202.876956845652;8228.341732661373;8264.83470330602;3085.4908940024643;3125.8905938292505;3131.1154598825906;3160.2099475131217;3183.1564635371647;885.3404213860587;917.9265658747418;969.3795970578835;983.8081574093127;1040.1886528507775;28736.568951465746;29255.56116658252;29615.85192074069;29657.703422965926;29858.552121718192;1001.9198464122853;1002.0880998291519;1010.6008126789877;1040.292601031306;1047.4082143588848;15226.238688065552;15402;15595.922020389826;15872.127033013296;15961.920190399205;411383;414497;415459;415481;418410;34976.475352869726;34980.30039399198;35041;35077.64922350744;35191.29617407638;1141.9543218271342;1175.0482109491168;1204.837346958167;1215.9513619455122;1248.2260998181005;27339.726602734514;29814.701852981194;30038.849805750833;30507.54238686377;30601;43118.56881431271;43205.351919720604;43528.34707479454;43627.56372436235;43697.56302436935;310851;311185;311341;312102;313126;22481.66277505806;25810.61284080703;26169.869150654125;26206.95172193091;27523;43270.78364608157;43973.78013109914;44073.77963110164;44852.77573612111;45101.54898450973;36874;37501.62498374981;37596.436053459765;37930.81034594809;38311.233775324894;37367.6263237375;37734.43398349082;37827.43258851174;37834.786865266826;37896;36637.45043824398;37232.25535489329;37301.253974920895;37827.810860945516;38008.239835202585;30936.381272374878;33403.498947516295;33410.66589334075;33419.331613368086;33530.49704254487;25521;25665.10172143966;25916.8704156478;26014.21957341283;26089.347766305993 10:27:09 INFO - PROCESS | 6514 | |2;jquery.html;378.96589306962375;381.4354754962655;383.92679530535105;392.8134136285263;394.6645351451265;16856.74714879276;17293.30826766928;18142.45572632823;18170.454886353396;18283.26866925323;15750.369985200578;15867.444639437623;16291.185440727975;16516;16522.917385413057;5047.394312682483;5244.895102097956;5301.1783173608155;5307.442718514559;5334.626576139653;3663.139162296858;3858.1897801461587;4759.881002974936;6083.361247069039;6095.359987201325;6055.939440605582;6115.29674087479;6147.938520614782;6154.076888466721;6196.907046394308;5993.9700301498215;6062.575619706622;6077.3314935357075;6092.177556029924;6142.324344322121;5273.075327505471;5378.220158077057;5384.7846086156505;5386.8922621547745;5393;17856.821431785647;17937.730934036;18069.09654517282;18094.09529523532;21452.5709485811;1983.6429442700307;2000.1799262302386;2010.3265406088979;2044.8977551122384;2050.2311633137574;12831.807522887164;12953.417096230693;13389.531366402227;13490.52783152585;13548.932255338661;1648.2747591059895;1796.9550761230944;1809.2672467650623;1813.76421065262;1838.3290099113726;70188.15915628005;71936.6403167986;72033;72138.27861721421;72585.6370718143;9913.306068575275;9993.850092248622;10099.293049486465;10150.746231344128;10288.897111028944;13636.86363136356;13729.244891531062;13754.65613359654;13771.517996870061;13778.82879955195;6657.400833924873;6738.831529211711;6749.2238392584495;6846.486513511407;6937.202221744564;5903.675297858659;5959.255093113361;6028.728707208186;6052.303985041688;6085.878282434415;4109.2808758467145;4258.616724494748;4328.480582330078;4350.912981740347;4400.359784129497;1725.8619310455133;1849.4636555399052;1921.6156768646326;1972.3392663457616;3070.831104289241;868.6699054359303;883.1962913748587;900.4417261297906;937.7843096087938;953.537534295866;16379.918100409423;16793.32826686919;16962.388573085536;17149;17628.471145865646;872.1322284327135;899.2805755395657;918.4581097152712;944.3767113704922;946.4037656276639;9621.51892405377;9668.323217374716;9735.026497350209;9895.505224738878;10075.798484030278;276206;279586;281479;283861;387065;82471;87024.5648771752;87486.1251387478;87546.56226718826;88052.5597372009;937.9718608441758;952.2049089010753;967.5065716484503;975.3806332978468;978.6819283732673;12356.752864942471;16031.35874565051;16137.435189768301;16194.190290485192;16291.023728208718;36953.44569831508;37174;38312;38683.22633547369;39261.8036909825;45846.54153458423;46139.76930115328;52836.47163528315;54467.45532544782;55114.17328739992;7651.464397492345;7805.531668099932;7893.131755506774;7994.840103197787;8012.559309238048;10674.199435042558;11538.769224615293;11617.883821162019;11718.472668730099;12424.875751242373;9970;10314.587416503557;10423.635172768916;10507.422091785025;10949.507272172612;10162.695119146141;10166.491675416348;10202.030807073315;10268.537915793659;10387.584496620051;10105.19158467306;10320.174386049248;10417.63538276187;10471.581136754749;10663.360198388122;7712.845743084995;7890.132085470708;7906.051273846945;8048.637811298623;8153.79615509617;9209.907900920905;10304.536295866854;10378.896211038094;10400.947995259976;10403.375797452178 10:27:09 INFO - PROCESS | 6514 | |3;mootools.html;1259.200407741084;1425.8146440962673;1455.0687559961623;1589.4675283779934;1760.6846996199995;7385.4830161888685;7753.147153813076;7756.844863102741;7970.880436793438;7997.400194985385;7772.4947878388;7937.325327347183;7944.165862584432;7955.244251796084;7974.1627129151475;2233.463968647521;2255.1994042115057;2256.571251462217;2264.3433404312727;2264.739554951177;2237.7874101960288;2291;2304.827137964651;2315.560043591712;2323.1172154581236;2247.7077979862597;2256.4020534558354;2259.7853203945683;2260.626996545568;2289.347535952254;2225.710657614516;2236.6756820261053;2257.492064285539;2261.649444336122;2265.2864347730497;2191.5726433345503;2199.5051113499494;2201.6917631531596;2205.6250437425674;2206.6028114939304;7659.655315510815;7770.106437759673;7870.409719271078;7874.842503149962;7912.841743165162;4491.348754430589;4583.2666773316105;4583.381243532147;4584.312353147021;4590.059037897223;3007.1730274174556;3015.9547606785914;3047.8628461719277;3061.0663747556987;3071.984640076808;901.5447199164446;921.6221748485989;939.6147579492375;951.9333646644737;956.1060408518058;10801.675949721443;10884.476173335739;10895.83656245157;10916.727081822939;10918.454077296183;4063.5733248009124;4194.937075943863;4213.220554197484;4259.084296876186;4263.296556068214;8563.614637341334;8611.48331100136;8612.78468038304;8618.827623447496;8619.82760344802;4523.751193684379;4578.5650363215445;4587.17430862448;4587.977060114678;4591.678582499193;3759.248150369937;3792.810359482015;3864.613538646169;4223;4223.915521689549;3410.334984677964;3507.5440192774777;3571.8035508047305;3576.499290099388;3606.657367550131;1031.9484025798681;1042.9061384475283;1044.4255659387306;1045.5765415006933;1048.2609760119099;766.4519868294196;875.8220193839276;882.2060145868769;918.5728636184207;928.2017464980112;5494.340679118532;5498.532624726863;5516.255305533701;5625.578081643893;5671.602987790815;902.7201567513961;905.7328088213993;908.9000209976897;924.9398789078689;927.800522887569;3802.4106263529197;3879.069023434412;3912.2762288976633;3915.4909861718365;3931.5478719947;9345.345825792128;9678.032196780407;9691.418514889128;9695.272854535797;9696.272779541563;9555.522223888778;9639.90360096404;9740.220782337396;9763.414195148314;9778.07108324708;7315.890261646079;7494.96252518723;7497.437692173109;7502.287282708134;7504.774856754306;5253.23828044939;5317.282166907418;5470.8905821882545;5530.142827861688;5533.667979921218;8754.124587541195;8993.28053755685;9009.054049324988;9011.774705632411;9131.315151363542;9105.317101217302;9117.316201284797;9135.360524763202;9221.308401869752;9230.169284764403;5798.739056742373;6089.878202435838;6404.551681382259;6459.321771213955;6470.935290647033;7435.51669141504;7740.7677769667;7748.070231572247;7754.534727916343;7755;6824.556403833735;7024.4029257513685;7064.717411303491;7102.786916392516;7157.964210178916;6641.535092543669;6787.796366109024;6792.796216113525;6912.827179320558;6920.065791118134;6167;6275.748970041147;6401.423871851555;6476.093346931528;6489.610623362613;4583.564561366665;4611.16998940194;4616.630669546361;4659.930101048555;4734.4081989751285;4645.3032045193495;4735.360726302043;4764.618830493621;4844;4868.756562171948 10:27:09 INFO - PROCESS | 6514 | |4;prototype.html;301.64104715388686;308.3109250824407;315.26700421519956;315.4086088583906;318.91548739584;4803.303520989454;4848.442429120652;4882.487338829425;4909.239067944465;4937.827176048834;4792.6405519586;4819.156647586676;4820.831270905519;4823.638227132961;4864.708117512942;3827.5981021992707;3839.520059992501;3844.2119365529998;3848.7113466489986;3848.8845334639864;3810.180466454817;3849.711271654623;3851.4030325299623;3870.2066076454257;3871;3749.700023998087;3795.9810200948955;3828.770273783568;3837.5011248537653;3847.461355410245;3803.505544279226;3818.1409182933894;3827.9664490587666;3832.540095188567;3834.789086600236;3398.1164897126678;3423.5891692997;3426.595096010624;3438.209211881281;3445.3453843769603;4671.719696818168;4681.752758675854;4688.578027977498;4710.293455981596;4732.976335118303;4074.2462644410584;4248.235317642823;4298.957010429887;4323.459567554056;4330.307150855848;4989.875253118665;5055.443901170868;5059.2916991621205;5065.544101030925;5081.8475445736685;3622.8913132606062;3627.4740162676526;3635.4910312556262;3645.471406646048;3652.7443078984484;5005.947561499804;5176.430592634807;5224.425313215544;5331.253624492574;5347.171188465794;3680;3690.8523659053335;3713.1274150574595;3714.312852122366;3719.9256014880093;3780.584135745066;3785.905352366158;3786.9431958520095;3788.2234142000825;3789.810509474515;4094.140230551558;4160.958390416057;4222.1766755483;4244.384564238168;4252.510961239435;5006.6245031622775;5060.696358218519;5061.240813877874;5061.949380506221;5098.158803797406;1290.664427248922;1301.102239454773;1309.1359702596242;1318.162966516269;1325.2578556008666;828.8218033122907;833.4332653795477;842.1704620948361;851.9531425771518;864.3992425264381;4064.6545043671617;4077.1448990709155;4077.347624380144;4092.3247664135083;4095.447114639545;4628.195003948463;4657.930131048037;4668.8365907193765;4671.369365135731;4680.3915490985955;4081.3469844824685;4089.161721847014;4092.3452247640234;4103.097318589906;4128.142335948835;2319.884005799703;2436.84160529565;2478.3804048987754;2484.4782595655115;2490.7509249074947;4403.722920353126;4442.466903971479;4447.909482543199;4490.730556166641;4499.820007199741;4744.722533184091;4761.809527618926;4763.976180119077;4795.808167673324;4801.4718380978065;4253.767865525359;4341.327094300388;4434.268345722984;4437.378766972626;4532.456105267257;4674.906501870011;4680.4149481314835;4695.394056298787;4715.646326525456;4750.738709371018;4694.06118776253;4722.173619616622;4948.777305021355;4951.529604687549;5110.693358398508;4964.801407943642;4975.378077740283;4986.800527978985;4990.700557966388;4997.475265097258;3619.2218672985437;3621.4386770050683;3632.8546858126438;3633.109888077438;3642.144096137353;5073.8731531712;5164.9741751291;5183.352080989876;5245.609913372883;5282.366116065943;5032.496750324938;5035.395752509576;5041.773120209526;5061.974690126526;5076.949230507647;5031.874203144951;5045.470225626404;5061.367329083864;5069.822556210515;5071.290019397361;4758.310045043519;4975.353204083446;4993.600511958962;5030.798768049237;5042;5104.617153713412;5113.897722045613;5118.462561430996;5128.974355128201;5130.435652078194;5010.899782004412;5011.373578302712;5024.472430394756;5026.220935754964;5029.5221953914315 10:27:09 INFO - PROCESS | 6514 | |5;yui.html;643.0193954219816;647.1554621219307;653.3466533466534;662.4303099334575;722.8698834209847;11197.776044479106;11712.355820429873;12798.168119072254;13266.800997985038;13322.333883305844;13558.796618050737;13650.11274267172;13658.180509169431;13732.176069435816;13736.58790236292;688.1432616392598;843.1147295339899;868.7263511993733;869.9782505437352;878.3500209844701;853.6158728572136;853.8889944307232;854.8888644476209;856.8200677857626;857.3741168946673;897.3718397122008;908.7773495493614;910.1535571918114;910.9954450227773;911.3757076402652;708.6846353372752;883.2933653077577;897.1701176411825;906.7823722306599;907.2152588011388;665.3778716899666;669.3875104279579;670.8993650952348;671.0571646836203;671.3554987212282;11260.380679062648;11265.493052812642;11304.37825919574;11310.264832785924;11312.717182070432;10863.293885897392;11309.095272378272;11465.254758440758;11503.654890353302;11742.236754610924;10871.29336593119;10928.289661172077;11011;11023.118150547936;11185.105191584735;4067.5729048449784;4073.97963010186;4143.751374917484;4160.43834082398;4181.435506206653;46225.768871155764;46281;46734.29898551524;46758.5324146761;46902.2964655527;9460.25476055093;9472.194863436685;9648.372855764354;9782.315237933277;10017;16928.661426771396;16943.576410589834;16962.406315779135;16964.575885602957;16973.15134243283;6254.405831446005;6313.2424109107205;6353.3329000455215;6382.968085159545;6540.9672951635885;3646.5988741238443;3648.562172539312;3666.9861427259316;3696.9815150924073;3832.5784163741964;2881.6109825173335;2971.301744090137;2975.8809647614285;2985.358147998147;2986.2385091801452;469.7064334790756;538.8518157506717;541.5694522854341;555.6832605414875;566.3571845954871;495.8165478772805;502.2040066494647;544.1375419959409;550.8319962411503;558.1432501110776;7702.9229707703325;8009.599520023976;8051.436399451982;8056.274935255738;8224.095349511548;492.99014019720124;503.8715127642501;539.5467807042025;588.3116753398534;592.1739173852452;3583.7133029357587;3651.8721844735305;3692.9446058309145;3694.131879008431;3752.0350906891003;59064;59278;59480.405195948355;60098;60403;52947.205791913155;53327;53377.46622533802;53383;55026.39683238037;48485;48529.514704852496;49585.25622115671;49759.502404976214;51312.74343628258;7070.4343652508705;7144.857102858018;7199.820004499929;7378.704851805867;7415.740449084256;32250.838745806122;32251;32565.34869302553;32825.50761738623;33321.83339083289;39031.804840975616;42563.7871810639;42900;43497.56502435062;43535;9582.329236953346;9694.5152742364;9710;9810.166135878244;9868.013198680075;10373.273870828969;10514.947425262824;10522.21083418762;10888.782224355627;10929.617463388744;8695.565221738761;9625.614975400906;9766.121049105615;9793.559289831832;9937.65218217359;9291.21024712907;9454.574544145667;9523.525553104086;9708.708738737849;9709.6601618943;9277.304202184729;9433.386829856037;9455.290853185901;9610.711678649652;9783.60865565398;7618.352440042659;7646.617669116411;7754.651040703069;7760.767176984699;8105.594720264081;8058.798530036796;8075.798105047421;8160.306373958043;8326.791830204293;8416.032156302104 10:27:09 INFO - PROCESS | 6514 | __end_tp_report 10:27:09 INFO - PROCESS | 6514 | __start_cc_report 10:27:09 INFO - PROCESS | 6514 | _x_x_mozilla_cycle_collect,1078 10:27:09 INFO - PROCESS | 6514 | __end_cc_report 10:27:09 INFO - PROCESS | 6514 | __startTimestamp1463592429447__endTimestamp 10:27:09 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | ------- Summary: start ------- 10:27:09 INFO - PROCESS | 6514 | Number of tests: 6 10:27:09 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | [#0] dojo.html Cycles:165 Average:4752.32 Median:4867.93 stddev:502.19 (10.3%) stddev-sans-first:476.21 10:27:09 INFO - PROCESS | 6514 | Values: 2662.5 2686.6 2714.0 2714.7 2728.6 4704.5 4745.3 4760.8 4809.2 4839.7 4740.3 4767.1 4777.2 4782.3 4804.6 4337.9 4401.4 4446.3 4479.5 4575.0 4470.5 4493.0 4520.4 4527.2 4541.9 4306.4 4336.2 4342.4 4374.8 4381.6 4352.6 4358.7 4361.2 4402.5 4438.7 4408.7 4418.8 4419.7 4423.7 4461.3 4561.2 4701.0 4727.5 4751.7 4800.9 5127.6 5170.0 5200.0 5204.3 5205.8 5150.0 5243.7 5246.3 5246.4 5247.0 4662.8 4762.6 4794.5 4797.9 4871.2 5297.5 5301.4 5310.3 5348.5 5351.9 5065.7 5115.8 5120.7 5121.4 5123.6 5023.0 5096.2 5113.8 5126.9 5162.4 5103.8 5110.5 5112.7 5121.1 5122.6 5110.6 5112.1 5112.8 5117.7 5150.9 4237.4 4265.8 4266.8 4271.3 4297.6 3753.7 3759.9 3785.3 3799.1 3815.9 4436.2 4450.6 4455.3 4497.4 4498.2 5040.1 5145.7 5148.0 5158.5 5216.9 4453.5 4467.5 4474.8 4498.0 4513.3 4636.5 4650.5 4665.9 4668.1 4718.6 4740.6 4829.9 4867.9 4874.5 4924.9 5070.3 5090.2 5098.2 5150.8 5165.7 4824.6 4849.0 4856.9 4857.1 4887.3 4862.0 4950.6 4999.8 5046.5 5078.4 5143.9 5177.6 5185.3 5189.5 5237.9 4836.6 5005.4 5026.1 5027.0 5028.3 4958.5 4975.1 5005.3 5011.1 5048.4 4956.8 4959.2 5003.7 5013.8 5015.4 4931.3 5007.5 5087.4 5087.8 5125.4 4927.8 4953.6 4974.1 4986.7 5031.4 10:27:09 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | [#1] ext.html Cycles:180 Average:47586.61 Median:19239.49 stddev:88651.10 (460.8%) stddev-sans-first:88829.44 10:27:09 INFO - PROCESS | 6514 | Values: 549.3 595.8 601.6 603.4 604.9 41388.0 42696.6 42888.8 42901.8 46879.0 42421.2 42441.2 43057.4 43246.1 43253.4 7477.4 7929.7 8032.2 8075.2 9886.5 9894.2 10279.7 10287.8 10298.1 10303.5 10308.8 10340.1 10343.8 10346.1 10372.3 7656.5 7854.8 7856.3 9903.8 10192.9 9784.2 10136.9 10137.9 10140.2 10153.5 39699.4 39961.6 39982.6 40000.2 40133.4 3103.4 3124.3 3127.9 3213.5 3395.9 29609.0 29974.6 30046.0 30078.2 30181.0 3425.5 3498.7 3528.6 3549.0 3573.6 259907.0 262100.0 264534.0 264608.0 264622.0 33235.7 49998.3 50081.0 50122.5 50250.7 33238.7 35373.5 35401.3 35477.3 35489.0 11471.8 11540.5 11604.7 11652.6 11656.8 9401.0 9461.0 9664.5 9695.1 10045.1 8169.2 8178.1 8202.9 8228.3 8264.8 3085.5 3125.9 3131.1 3160.2 3183.2 885.3 917.9 969.4 983.8 1040.2 28736.6 29255.6 29615.9 29657.7 29858.6 1001.9 1002.1 1010.6 1040.3 1047.4 15226.2 15402.0 15595.9 15872.1 15961.9 411383.0 414497.0 415459.0 415481.0 418410.0 34976.5 34980.3 35041.0 35077.6 35191.3 1142.0 1175.0 1204.8 1216.0 1248.2 27339.7 29814.7 30038.8 30507.5 30601.0 43118.6 43205.4 43528.3 43627.6 43697.6 310851.0 311185.0 311341.0 312102.0 313126.0 22481.7 25810.6 26169.9 26207.0 27523.0 43270.8 43973.8 44073.8 44852.8 45101.5 36874.0 37501.6 37596.4 37930.8 38311.2 37367.6 37734.4 37827.4 37834.8 37896.0 36637.5 37232.3 37301.3 37827.8 38008.2 30936.4 33403.5 33410.7 33419.3 33530.5 25521.0 25665.1 25916.9 26014.2 26089.3 10:27:09 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | [#2] jquery.html Cycles:180 Average:22312.42 Median:193728.91 stddev:51395.80 (26.5%) stddev-sans-first:51513.60 10:27:09 INFO - PROCESS | 6514 | Values: 379.0 381.4 383.9 392.8 394.7 16856.7 17293.3 18142.5 18170.5 18283.3 15750.4 15867.4 16291.2 16516.0 16522.9 5047.4 5244.9 5301.2 5307.4 5334.6 3663.1 3858.2 4759.9 6083.4 6095.4 6055.9 6115.3 6147.9 6154.1 6196.9 5994.0 6062.6 6077.3 6092.2 6142.3 5273.1 5378.2 5384.8 5386.9 5393.0 17856.8 17937.7 18069.1 18094.1 21452.6 1983.6 2000.2 2010.3 2044.9 2050.2 12831.8 12953.4 13389.5 13490.5 13548.9 1648.3 1797.0 1809.3 1813.8 1838.3 70188.2 71936.6 72033.0 72138.3 72585.6 9913.3 9993.9 10099.3 10150.7 10288.9 13636.9 13729.2 13754.7 13771.5 13778.8 6657.4 6738.8 6749.2 6846.5 6937.2 5903.7 5959.3 6028.7 6052.3 6085.9 4109.3 4258.6 4328.5 4350.9 4400.4 1725.9 1849.5 1921.6 1972.3 3070.8 868.7 883.2 900.4 937.8 953.5 16379.9 16793.3 16962.4 17149.0 17628.5 872.1 899.3 918.5 944.4 946.4 9621.5 9668.3 9735.0 9895.5 10075.8 276206.0 279586.0 281479.0 283861.0 387065.0 82471.0 87024.6 87486.1 87546.6 88052.6 938.0 952.2 967.5 975.4 978.7 12356.8 16031.4 16137.4 16194.2 16291.0 36953.4 37174.0 38312.0 38683.2 39261.8 45846.5 46139.8 52836.5 54467.5 55114.2 7651.5 7805.5 7893.1 7994.8 8012.6 10674.2 11538.8 11617.9 11718.5 12424.9 9970.0 10314.6 10423.6 10507.4 10949.5 10162.7 10166.5 10202.0 10268.5 10387.6 10105.2 10320.2 10417.6 10471.6 10663.4 7712.8 7890.1 7906.1 8048.6 8153.8 9209.9 10304.5 10378.9 10400.9 10403.4 10:27:09 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | [#3] mootools.html Cycles:180 Average:5187.57 Median:5523.20 stddev:2882.21 (52.2%) stddev-sans-first:2875.17 10:27:09 INFO - PROCESS | 6514 | Values: 1259.2 1425.8 1455.1 1589.5 1760.7 7385.5 7753.1 7756.8 7970.9 7997.4 7772.5 7937.3 7944.2 7955.2 7974.2 2233.5 2255.2 2256.6 2264.3 2264.7 2237.8 2291.0 2304.8 2315.6 2323.1 2247.7 2256.4 2259.8 2260.6 2289.3 2225.7 2236.7 2257.5 2261.6 2265.3 2191.6 2199.5 2201.7 2205.6 2206.6 7659.7 7770.1 7870.4 7874.8 7912.8 4491.3 4583.3 4583.4 4584.3 4590.1 3007.2 3016.0 3047.9 3061.1 3072.0 901.5 921.6 939.6 951.9 956.1 10801.7 10884.5 10895.8 10916.7 10918.5 4063.6 4194.9 4213.2 4259.1 4263.3 8563.6 8611.5 8612.8 8618.8 8619.8 4523.8 4578.6 4587.2 4588.0 4591.7 3759.2 3792.8 3864.6 4223.0 4223.9 3410.3 3507.5 3571.8 3576.5 3606.7 1031.9 1042.9 1044.4 1045.6 1048.3 766.5 875.8 882.2 918.6 928.2 5494.3 5498.5 5516.3 5625.6 5671.6 902.7 905.7 908.9 924.9 927.8 3802.4 3879.1 3912.3 3915.5 3931.5 9345.3 9678.0 9691.4 9695.3 9696.3 9555.5 9639.9 9740.2 9763.4 9778.1 7315.9 7495.0 7497.4 7502.3 7504.8 5253.2 5317.3 5470.9 5530.1 5533.7 8754.1 8993.3 9009.1 9011.8 9131.3 9105.3 9117.3 9135.4 9221.3 9230.2 5798.7 6089.9 6404.6 6459.3 6470.9 7435.5 7740.8 7748.1 7754.5 7755.0 6824.6 7024.4 7064.7 7102.8 7158.0 6641.5 6787.8 6792.8 6912.8 6920.1 6167.0 6275.7 6401.4 6476.1 6489.6 4583.6 4611.2 4616.6 4659.9 4734.4 4645.3 4735.4 4764.6 4844.0 4868.8 10:27:09 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | [#4] prototype.html Cycles:180 Average:4111.92 Median:4643.06 stddev:1181.48 (25.4%) stddev-sans-first:1149.66 10:27:09 INFO - PROCESS | 6514 | Values: 301.6 308.3 315.3 315.4 318.9 4803.3 4848.4 4882.5 4909.2 4937.8 4792.6 4819.2 4820.8 4823.6 4864.7 3827.6 3839.5 3844.2 3848.7 3848.9 3810.2 3849.7 3851.4 3870.2 3871.0 3749.7 3796.0 3828.8 3837.5 3847.5 3803.5 3818.1 3828.0 3832.5 3834.8 3398.1 3423.6 3426.6 3438.2 3445.3 4671.7 4681.8 4688.6 4710.3 4733.0 4074.2 4248.2 4299.0 4323.5 4330.3 4989.9 5055.4 5059.3 5065.5 5081.8 3622.9 3627.5 3635.5 3645.5 3652.7 5005.9 5176.4 5224.4 5331.3 5347.2 3680.0 3690.9 3713.1 3714.3 3719.9 3780.6 3785.9 3786.9 3788.2 3789.8 4094.1 4161.0 4222.2 4244.4 4252.5 5006.6 5060.7 5061.2 5061.9 5098.2 1290.7 1301.1 1309.1 1318.2 1325.3 828.8 833.4 842.2 852.0 864.4 4064.7 4077.1 4077.3 4092.3 4095.4 4628.2 4657.9 4668.8 4671.4 4680.4 4081.3 4089.2 4092.3 4103.1 4128.1 2319.9 2436.8 2478.4 2484.5 2490.8 4403.7 4442.5 4447.9 4490.7 4499.8 4744.7 4761.8 4764.0 4795.8 4801.5 4253.8 4341.3 4434.3 4437.4 4532.5 4674.9 4680.4 4695.4 4715.6 4750.7 4694.1 4722.2 4948.8 4951.5 5110.7 4964.8 4975.4 4986.8 4990.7 4997.5 3619.2 3621.4 3632.9 3633.1 3642.1 5073.9 5165.0 5183.4 5245.6 5282.4 5032.5 5035.4 5041.8 5062.0 5076.9 5031.9 5045.5 5061.4 5069.8 5071.3 4758.3 4975.4 4993.6 5030.8 5042.0 5104.6 5113.9 5118.5 5129.0 5130.4 5010.9 5011.4 5024.5 5026.2 5029.5 10:27:09 INFO - PROCESS | 6514 | 10:27:09 INFO - PROCESS | 6514 | [#5] yui.html Cycles:180 Average:13283.91 Median:27791.04 stddev:16282.44 (58.6%) stddev-sans-first:16300.44 10:27:09 INFO - PROCESS | 6514 | Values: 643.0 647.2 653.3 662.4 722.9 11197.8 11712.4 12798.2 13266.8 13322.3 13558.8 13650.1 13658.2 13732.2 13736.6 688.1 843.1 868.7 870.0 878.4 853.6 853.9 854.9 856.8 857.4 897.4 908.8 910.2 911.0 911.4 708.7 883.3 897.2 906.8 907.2 665.4 669.4 670.9 671.1 671.4 11260.4 11265.5 11304.4 11310.3 11312.7 10863.3 11309.1 11465.3 11503.7 11742.2 10871.3 10928.3 11011.0 11023.1 11185.1 4067.6 4074.0 4143.8 4160.4 4181.4 46225.8 46281.0 46734.3 46758.5 46902.3 9460.3 9472.2 9648.4 9782.3 10017.0 16928.7 16943.6 16962.4 16964.6 16973.2 6254.4 6313.2 6353.3 6383.0 6541.0 3646.6 3648.6 3667.0 3697.0 3832.6 2881.6 2971.3 2975.9 2985.4 2986.2 469.7 538.9 541.6 555.7 566.4 495.8 502.2 544.1 550.8 558.1 7702.9 8009.6 8051.4 8056.3 8224.1 493.0 503.9 539.5 588.3 592.2 3583.7 3651.9 3692.9 3694.1 3752.0 59064.0 59278.0 59480.4 60098.0 60403.0 52947.2 53327.0 53377.5 53383.0 55026.4 48485.0 48529.5 49585.3 49759.5 51312.7 7070.4 7144.9 7199.8 7378.7 7415.7 32250.8 32251.0 32565.3 32825.5 33321.8 39031.8 42563.8 42900.0 43497.6 43535.0 9582.3 9694.5 9710.0 9810.2 9868.0 10373.3 10514.9 10522.2 10888.8 10929.6 8695.6 9625.6 9766.1 9793.6 9937.7 9291.2 9454.6 9523.5 9708.7 9709.7 9277.3 9433.4 9455.3 9610.7 9783.6 7618.4 7646.6 7754.7 7760.8 8105.6 8058.8 8075.8 8160.3 8326.8 8416.0 10:27:09 INFO - PROCESS | 6514 | -------- Summary: end -------- 10:27:09 INFO - PROCESS | 6514 | 10:27:10 INFO - TEST-INFO | 6514: exit 0 10:27:10 INFO - TEST-OK | dromaeo_css | took 1119210ms 10:27:10 INFO - TEST-START | kraken 10:27:10 INFO - operating with platform_type : linux_ 10:27:10 INFO - Initialising browser for kraken test... 10:27:10 INFO - TEST-INFO | started process 6696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7LhGoJ/profile http://localhost:37419/getInfo.html) 10:27:14 INFO - PROCESS | 6696 | __metrics Screen width/height:1600/1200 10:27:14 INFO - PROCESS | 6696 | colorDepth:24 10:27:14 INFO - PROCESS | 6696 | Browser inner width/height: 1024/697 10:27:14 INFO - PROCESS | 6696 | __metrics 10:27:15 ERROR - PROCESS | 6696 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:27:16 INFO - TEST-INFO | 6696: exit 0 10:27:16 INFO - Browser initialized. 10:27:16 INFO - Running cycle 1/1 for kraken test... 10:27:16 INFO - TEST-INFO | started process 6776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7LhGoJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:28 INFO - PROCESS | 6776 | RSS: Main: 155283456 10:27:28 INFO - PROCESS | 6776 | 10:27:30 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37419/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:31 INFO - PROCESS | 6776 | RSS: Main: 210550784 10:27:31 INFO - PROCESS | 6776 | 10:27:34 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37419/tests/kraken/driver.html?testName=audio-dft) 10:27:35 INFO - PROCESS | 6776 | RSS: Main: 198844416 10:27:35 INFO - PROCESS | 6776 | 10:27:38 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37419/tests/kraken/driver.html?testName=audio-fft) 10:27:39 INFO - PROCESS | 6776 | RSS: Main: 268136448 10:27:39 INFO - PROCESS | 6776 | 10:27:41 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37419/tests/kraken/driver.html?testName=audio-oscillator) 10:27:42 INFO - PROCESS | 6776 | RSS: Main: 176680960 10:27:42 INFO - PROCESS | 6776 | 10:27:44 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37419/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:45 INFO - PROCESS | 6776 | RSS: Main: 180158464 10:27:45 INFO - PROCESS | 6776 | 10:27:48 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37419/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:49 INFO - PROCESS | 6776 | RSS: Main: 216653824 10:27:49 INFO - PROCESS | 6776 | 10:27:52 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37419/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:53 INFO - PROCESS | 6776 | RSS: Main: 214622208 10:27:53 INFO - PROCESS | 6776 | 10:27:56 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37419/tests/kraken/driver.html?testName=json-parse-financial) 10:27:57 INFO - PROCESS | 6776 | RSS: Main: 215416832 10:27:57 INFO - PROCESS | 6776 | 10:27:59 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37419/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:59 INFO - PROCESS | 6776 | RSS: Main: 207585280 10:27:59 INFO - PROCESS | 6776 | 10:28:01 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:02 INFO - PROCESS | 6776 | RSS: Main: 210784256 10:28:02 INFO - PROCESS | 6776 | 10:28:04 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:05 INFO - PROCESS | 6776 | RSS: Main: 214482944 10:28:05 INFO - PROCESS | 6776 | 10:28:08 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:08 INFO - PROCESS | 6776 | RSS: Main: 219127808 10:28:08 INFO - PROCESS | 6776 | 10:28:11 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:12 INFO - PROCESS | 6776 | RSS: Main: 219070464 10:28:12 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | Cycle 1(1): loaded http://localhost:37419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37419/tests/kraken/driver.html?testName=ai-astar) 10:28:14 INFO - PROCESS | 6776 | RSS: Main: 265609216 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | __start_tp_report 10:28:14 INFO - PROCESS | 6776 | _x_x_mozilla_page_load 10:28:14 INFO - PROCESS | 6776 | _x_x_mozilla_page_load_details 10:28:14 INFO - PROCESS | 6776 | |i|pagename|runs| 10:28:14 INFO - PROCESS | 6776 | |0;ai-astar;113;109;113;113;114;112;112;113;111;114 10:28:14 INFO - PROCESS | 6776 | |1;audio-beat-detection;158;129;156;235;127;154;159;130;190;128 10:28:14 INFO - PROCESS | 6776 | |2;audio-dft;162;162;162;162;161;163;162;162;160;161 10:28:14 INFO - PROCESS | 6776 | |3;audio-fft;75;76;77;155;77;75;77;76;133;75 10:28:14 INFO - PROCESS | 6776 | |4;audio-oscillator;93;91;152;93;93;92;135;92;91;121 10:28:14 INFO - PROCESS | 6776 | |5;imaging-gaussian-blur;119;116;118;119;119;117;116;116;116;116 10:28:14 INFO - PROCESS | 6776 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;145;145 10:28:14 INFO - PROCESS | 6776 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 10:28:14 INFO - PROCESS | 6776 | |8;json-parse-financial;66;66;67;65;66;66;66;66;65;67 10:28:14 INFO - PROCESS | 6776 | |9;json-stringify-tinderbox;65;65;64;64;65;65;64;65;65;65 10:28:14 INFO - PROCESS | 6776 | |10;stanford-crypto-aes;83;82;82;82;84;84;83;84;147;82 10:28:14 INFO - PROCESS | 6776 | |11;stanford-crypto-ccm;132;138;142;131;130;130;134;129;153;130 10:28:14 INFO - PROCESS | 6776 | |12;stanford-crypto-pbkdf2;165;173;170;172;168;166;166;170;165;165 10:28:14 INFO - PROCESS | 6776 | |13;stanford-crypto-sha256-iterative;69;69;67;66;66;66;66;66;65;64 10:28:14 INFO - PROCESS | 6776 | __end_tp_report 10:28:14 INFO - PROCESS | 6776 | __start_cc_report 10:28:14 INFO - PROCESS | 6776 | _x_x_mozilla_cycle_collect,2091 10:28:14 INFO - PROCESS | 6776 | __end_cc_report 10:28:14 INFO - PROCESS | 6776 | __startTimestamp1463592494312__endTimestamp 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | ------- Summary: start ------- 10:28:14 INFO - PROCESS | 6776 | Number of tests: 14 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.51 (1.3%) stddev-sans-first:1.58 10:28:14 INFO - PROCESS | 6776 | Values: 113.0 109.0 113.0 113.0 114.0 112.0 112.0 113.0 111.0 114.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#1] audio-beat-detection Cycles:10 Average:156.60 Median:157.00 stddev:34.06 (21.7%) stddev-sans-first:36.12 10:28:14 INFO - PROCESS | 6776 | Values: 158.0 129.0 156.0 235.0 127.0 154.0 159.0 130.0 190.0 128.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 10:28:14 INFO - PROCESS | 6776 | Values: 162.0 162.0 162.0 162.0 161.0 163.0 162.0 162.0 160.0 161.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#3] audio-fft Cycles:10 Average:89.60 Median:76.00 stddev:29.15 (38.4%) stddev-sans-first:30.43 10:28:14 INFO - PROCESS | 6776 | Values: 75.0 76.0 77.0 155.0 77.0 75.0 77.0 76.0 133.0 75.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:92.00 stddev:22.43 (24.4%) stddev-sans-first:23.34 10:28:14 INFO - PROCESS | 6776 | Values: 93.0 91.0 152.0 93.0 93.0 92.0 135.0 92.0 91.0 121.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:1.40 (1.2%) stddev-sans-first:1.32 10:28:14 INFO - PROCESS | 6776 | Values: 119.0 116.0 118.0 119.0 119.0 117.0 116.0 116.0 116.0 116.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:28:14 INFO - PROCESS | 6776 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:28:14 INFO - PROCESS | 6776 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 10:28:14 INFO - PROCESS | 6776 | Values: 66.0 66.0 67.0 65.0 66.0 66.0 66.0 66.0 65.0 67.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 10:28:14 INFO - PROCESS | 6776 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:83.00 stddev:20.29 (24.4%) stddev-sans-first:21.40 10:28:14 INFO - PROCESS | 6776 | Values: 83.0 82.0 82.0 82.0 84.0 84.0 83.0 84.0 147.0 82.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:133.00 stddev:7.59 (5.7%) stddev-sans-first:7.98 10:28:14 INFO - PROCESS | 6776 | Values: 132.0 138.0 142.0 131.0 130.0 130.0 134.0 129.0 153.0 130.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:169.00 stddev:3.06 (1.8%) stddev-sans-first:3.04 10:28:14 INFO - PROCESS | 6776 | Values: 165.0 173.0 170.0 172.0 168.0 166.0 166.0 170.0 165.0 165.0 10:28:14 INFO - PROCESS | 6776 | 10:28:14 INFO - PROCESS | 6776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:1.58 (2.4%) stddev-sans-first:1.36 10:28:14 INFO - PROCESS | 6776 | Values: 69.0 69.0 67.0 66.0 66.0 66.0 66.0 66.0 65.0 64.0 10:28:14 INFO - PROCESS | 6776 | -------- Summary: end -------- 10:28:14 INFO - PROCESS | 6776 | 10:28:15 INFO - TEST-INFO | 6776: exit 0 10:28:15 INFO - TEST-OK | kraken | took 65124ms 10:28:15 INFO - SUITE-END | took 1184s 10:28:15 INFO - Completed test suite (00:19:44) 10:28:15 INFO - javascript benchmark 10:28:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.4675064987, 2686.570148776196, 2713.9592906106404, 2714.742099500548, 2728.6043523689063, 4704.4589872164715, 4745.311929770181, 4760.809567617292, 4809.158397280479, 4839.685420447673, 4740.288956656504, 4767.0942520921, 4777.187878060729, 4782.258749893764, 4804.5916097131785, 4337.934930976038, 4401.383806267125, 4446.266366049598, 4479.462464504248, 4575.039241759235, 4470.530594287618, 4493.033997690496, 4520.412346394964, 4527.16247494213, 4541.931871021938, 4306.397104405386, 4336.176126535948, 4342.370356298351, 4374.803133858984, 4381.605655490989, 4352.630026447724, 4358.65130789536, 4361.193179261815, 4402.471703395581, 4438.711483753578, 4408.669349798778, 4418.7790610469665, 4419.690621656486, 4423.712458690175, 4461.330800379937, 4561.224591819366, 4701.0127873146685, 4727.5272472752795, 4751.738654374008, 4800.903981920377, 5127.564157046656, 5170.043541944752, 5200.0, 5204.29741984831, 5205.765740541647, 5150.0472412603785, 5243.659162154448, 5246.265522826808, 5246.422893481752, 5247.029299579552, 4662.8368007119925, 4762.64280178988, 4794.520547945178, 4797.856064318076, 4871.2206047032305, 5297.54970827484, 5301.443348448357, 5310.283111779938, 5348.5186333230195, 5351.9464805351445, 5065.721385323769, 5115.7953681852305, 5120.718360490208, 5121.385433747974, 5123.641345105807, 5023.045621331935, 5096.184610462308, 5113.821016264413, 5126.948975460022, 5162.380514338229, 5103.755481093356, 5110.48895110486, 5112.718800465936, 5121.052605268037, 5122.615803814729, 5110.616703747234, 5112.130937740593, 5112.821051263262, 5117.71852548106, 5150.922736158961, 4237.406763053175, 4265.786710664454, 4266.786660666954, 4271.337942618899, 4297.634701050446, 3753.718471114623, 3759.9248015039548, 3785.3186426442953, 3799.0882188274613, 3815.923681526354, 4436.179306828247, 4450.599446049871, 4455.309427038814, 4497.415336006364, 4498.212812757754, 5040.092783299041, 5145.665531740425, 5147.970405918832, 5158.458361872024, 5216.869578260498, 4453.487848897418, 4467.508574056851, 4474.7762611869275, 4497.987952710614, 4513.323001549794, 4636.466806317249, 4650.488446270908, 4665.883352916137, 4668.11305851887, 4718.622510199176, 4740.644451666208, 4829.903401932012, 4867.926981095357, 4874.53691899269, 4924.926126108111, 5070.264811602223, 5090.211017292326, 5098.209777484496, 5150.768215430239, 5165.66423182492, 4824.589909857561, 4848.951510484992, 4856.902861942812, 4857.101436234308, 4887.266909963391, 4861.95138048615, 4950.579200767975, 4999.750012499433, 5046.495350465071, 5078.390593128848, 5143.92284115746, 5177.585793136615, 5185.274061631299, 5189.506996835295, 5237.947620523899, 4836.588889944253, 5005.424376196784, 5026.145555255543, 5027.0, 5028.321176641253, 4958.528939750718, 4975.0547395994645, 5005.299258103795, 5011.148104822262, 5048.3941926969, 4956.826511072095, 4959.156943319572, 5003.674761140514, 5013.774380152829, 5015.398152221756, 4931.260310953386, 5007.524285192901, 5087.389513258433, 5087.771050302671, 5125.359330083739, 4927.827526036572, 4953.628477864103, 4974.0797952378925, 4986.675866068694, 5031.371078615173], "value": 4720.179187929809, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.299642955232, 595.8421018430115, 601.5548494114357, 603.3815339277243, 604.8971674815281, 41387.99999999996, 42696.57303426965, 42888.78555607225, 42901.78549107254, 46879.0, 42421.15157696844, 42441.15117697644, 43057.35413968793, 43246.13507729844, 43253.35119973195, 7477.401807855385, 7929.6828126875, 8032.1566235545015, 8075.192480751907, 9886.456244906527, 9894.158996485272, 10279.691609251697, 10287.79424411515, 10298.12465940396, 10303.53634086464, 10308.845367319496, 10340.121089707383, 10343.844842327371, 10346.120579750692, 10372.273940824145, 7656.502327348732, 7854.842903141962, 7856.332211762007, 9903.801923961553, 10192.898071019306, 9784.217262618973, 10136.89863101367, 10137.949310253402, 10140.239482038876, 10153.4923253837, 39699.40450893239, 39961.600383996076, 39982.60017399818, 40000.19999600021, 40133.397999030036, 3103.3638104188585, 3124.297033167542, 3127.9218019549467, 3213.453712868818, 3395.8641654333796, 29609.0, 29974.55038174429, 30046.0, 30078.156152803393, 30181.0, 3425.520427140202, 3498.6851183393364, 3528.558930133733, 3549.0, 3573.6069032406413, 259907.0, 262100.0, 264534.0, 264608.0, 264622.0, 33235.66764332326, 49998.250131240304, 50081.0, 50122.498775012515, 50250.74874625603, 33238.66761332404, 35373.46939795905, 35401.291974160886, 35477.29045419077, 35489.0, 11471.770564588662, 11540.538378464935, 11604.6518604442, 11652.592159274385, 11656.766864662828, 9400.95299523498, 9461.0, 9664.468454235084, 9695.078967498077, 10045.146162576262, 8169.183081691784, 8178.100408955011, 8202.876956845652, 8228.341732661373, 8264.83470330602, 3085.4908940024643, 3125.8905938292505, 3131.1154598825906, 3160.2099475131217, 3183.1564635371647, 885.3404213860587, 917.9265658747418, 969.3795970578835, 983.8081574093127, 1040.1886528507775, 28736.568951465746, 29255.56116658252, 29615.85192074069, 29657.703422965926, 29858.552121718192, 1001.9198464122853, 1002.0880998291519, 1010.6008126789877, 1040.292601031306, 1047.4082143588848, 15226.238688065552, 15402.0, 15595.922020389826, 15872.127033013296, 15961.920190399205, 411383.0, 414497.0, 415459.0, 415481.0, 418410.0, 34976.475352869726, 34980.30039399198, 35041.0, 35077.64922350744, 35191.29617407638, 1141.9543218271342, 1175.0482109491168, 1204.837346958167, 1215.9513619455122, 1248.2260998181005, 27339.726602734514, 29814.701852981194, 30038.849805750833, 30507.54238686377, 30601.0, 43118.56881431271, 43205.351919720604, 43528.34707479454, 43627.56372436235, 43697.56302436935, 310851.0, 311185.0, 311341.0, 312102.0, 313126.0, 22481.66277505806, 25810.61284080703, 26169.869150654125, 26206.95172193091, 27523.0, 43270.78364608157, 43973.78013109914, 44073.77963110164, 44852.77573612111, 45101.54898450973, 36874.0, 37501.62498374981, 37596.436053459765, 37930.81034594809, 38311.233775324894, 37367.6263237375, 37734.43398349082, 37827.43258851174, 37834.786865266826, 37896.0, 36637.45043824398, 37232.25535489329, 37301.253974920895, 37827.810860945516, 38008.239835202585, 30936.381272374878, 33403.498947516295, 33410.66589334075, 33419.331613368086, 33530.49704254487, 25521.0, 25665.10172143966, 25916.8704156478, 26014.21957341283, 26089.347766305993], "value": 17065.866312497637, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.96589306962375, 381.4354754962655, 383.92679530535105, 392.8134136285263, 394.6645351451265, 16856.74714879276, 17293.30826766928, 18142.45572632823, 18170.454886353396, 18283.26866925323, 15750.369985200578, 15867.444639437623, 16291.185440727975, 16516.0, 16522.917385413057, 5047.394312682483, 5244.895102097956, 5301.1783173608155, 5307.442718514559, 5334.626576139653, 3663.139162296858, 3858.1897801461587, 4759.881002974936, 6083.361247069039, 6095.359987201325, 6055.939440605582, 6115.29674087479, 6147.938520614782, 6154.076888466721, 6196.907046394308, 5993.9700301498215, 6062.575619706622, 6077.3314935357075, 6092.177556029924, 6142.324344322121, 5273.075327505471, 5378.220158077057, 5384.7846086156505, 5386.8922621547745, 5393.0, 17856.821431785647, 17937.730934036, 18069.09654517282, 18094.09529523532, 21452.5709485811, 1983.6429442700307, 2000.1799262302386, 2010.3265406088979, 2044.8977551122384, 2050.2311633137574, 12831.807522887164, 12953.417096230693, 13389.531366402227, 13490.52783152585, 13548.932255338661, 1648.2747591059895, 1796.9550761230944, 1809.2672467650623, 1813.76421065262, 1838.3290099113726, 70188.15915628005, 71936.6403167986, 72033.0, 72138.27861721421, 72585.6370718143, 9913.306068575275, 9993.850092248622, 10099.293049486465, 10150.746231344128, 10288.897111028944, 13636.86363136356, 13729.244891531062, 13754.65613359654, 13771.517996870061, 13778.82879955195, 6657.400833924873, 6738.831529211711, 6749.2238392584495, 6846.486513511407, 6937.202221744564, 5903.675297858659, 5959.255093113361, 6028.728707208186, 6052.303985041688, 6085.878282434415, 4109.2808758467145, 4258.616724494748, 4328.480582330078, 4350.912981740347, 4400.359784129497, 1725.8619310455133, 1849.4636555399052, 1921.6156768646326, 1972.3392663457616, 3070.831104289241, 868.6699054359303, 883.1962913748587, 900.4417261297906, 937.7843096087938, 953.537534295866, 16379.918100409423, 16793.32826686919, 16962.388573085536, 17149.0, 17628.471145865646, 872.1322284327135, 899.2805755395657, 918.4581097152712, 944.3767113704922, 946.4037656276639, 9621.51892405377, 9668.323217374716, 9735.026497350209, 9895.505224738878, 10075.798484030278, 276206.0, 279586.0, 281479.0, 283861.0, 387065.0, 82471.0, 87024.5648771752, 87486.1251387478, 87546.56226718826, 88052.5597372009, 937.9718608441758, 952.2049089010753, 967.5065716484503, 975.3806332978468, 978.6819283732673, 12356.752864942471, 16031.35874565051, 16137.435189768301, 16194.190290485192, 16291.023728208718, 36953.44569831508, 37174.0, 38312.0, 38683.22633547369, 39261.8036909825, 45846.54153458423, 46139.76930115328, 52836.47163528315, 54467.45532544782, 55114.17328739992, 7651.464397492345, 7805.531668099932, 7893.131755506774, 7994.840103197787, 8012.559309238048, 10674.199435042558, 11538.769224615293, 11617.883821162019, 11718.472668730099, 12424.875751242373, 9970.0, 10314.587416503557, 10423.635172768916, 10507.422091785025, 10949.507272172612, 10162.695119146141, 10166.491675416348, 10202.030807073315, 10268.537915793659, 10387.584496620051, 10105.19158467306, 10320.174386049248, 10417.63538276187, 10471.581136754749, 10663.360198388122, 7712.845743084995, 7890.132085470708, 7906.051273846945, 8048.637811298623, 8153.79615509617, 9209.907900920905, 10304.536295866854, 10378.896211038094, 10400.947995259976, 10403.375797452178], "value": 8359.883851093635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.200407741084, 1425.8146440962673, 1455.0687559961623, 1589.4675283779934, 1760.6846996199995, 7385.4830161888685, 7753.147153813076, 7756.844863102741, 7970.880436793438, 7997.400194985385, 7772.4947878388, 7937.325327347183, 7944.165862584432, 7955.244251796084, 7974.1627129151475, 2233.463968647521, 2255.1994042115057, 2256.571251462217, 2264.3433404312727, 2264.739554951177, 2237.7874101960288, 2291.0, 2304.827137964651, 2315.560043591712, 2323.1172154581236, 2247.7077979862597, 2256.4020534558354, 2259.7853203945683, 2260.626996545568, 2289.347535952254, 2225.710657614516, 2236.6756820261053, 2257.492064285539, 2261.649444336122, 2265.2864347730497, 2191.5726433345503, 2199.5051113499494, 2201.6917631531596, 2205.6250437425674, 2206.6028114939304, 7659.655315510815, 7770.106437759673, 7870.409719271078, 7874.842503149962, 7912.841743165162, 4491.348754430589, 4583.2666773316105, 4583.381243532147, 4584.312353147021, 4590.059037897223, 3007.1730274174556, 3015.9547606785914, 3047.8628461719277, 3061.0663747556987, 3071.984640076808, 901.5447199164446, 921.6221748485989, 939.6147579492375, 951.9333646644737, 956.1060408518058, 10801.675949721443, 10884.476173335739, 10895.83656245157, 10916.727081822939, 10918.454077296183, 4063.5733248009124, 4194.937075943863, 4213.220554197484, 4259.084296876186, 4263.296556068214, 8563.614637341334, 8611.48331100136, 8612.78468038304, 8618.827623447496, 8619.82760344802, 4523.751193684379, 4578.5650363215445, 4587.17430862448, 4587.977060114678, 4591.678582499193, 3759.248150369937, 3792.810359482015, 3864.613538646169, 4223.0, 4223.915521689549, 3410.334984677964, 3507.5440192774777, 3571.8035508047305, 3576.499290099388, 3606.657367550131, 1031.9484025798681, 1042.9061384475283, 1044.4255659387306, 1045.5765415006933, 1048.2609760119099, 766.4519868294196, 875.8220193839276, 882.2060145868769, 918.5728636184207, 928.2017464980112, 5494.340679118532, 5498.532624726863, 5516.255305533701, 5625.578081643893, 5671.602987790815, 902.7201567513961, 905.7328088213993, 908.9000209976897, 924.9398789078689, 927.800522887569, 3802.4106263529197, 3879.069023434412, 3912.2762288976633, 3915.4909861718365, 3931.5478719947, 9345.345825792128, 9678.032196780407, 9691.418514889128, 9695.272854535797, 9696.272779541563, 9555.522223888778, 9639.90360096404, 9740.220782337396, 9763.414195148314, 9778.07108324708, 7315.890261646079, 7494.96252518723, 7497.437692173109, 7502.287282708134, 7504.774856754306, 5253.23828044939, 5317.282166907418, 5470.8905821882545, 5530.142827861688, 5533.667979921218, 8754.124587541195, 8993.28053755685, 9009.054049324988, 9011.774705632411, 9131.315151363542, 9105.317101217302, 9117.316201284797, 9135.360524763202, 9221.308401869752, 9230.169284764403, 5798.739056742373, 6089.878202435838, 6404.551681382259, 6459.321771213955, 6470.935290647033, 7435.51669141504, 7740.7677769667, 7748.070231572247, 7754.534727916343, 7755.0, 6824.556403833735, 7024.4029257513685, 7064.717411303491, 7102.786916392516, 7157.964210178916, 6641.535092543669, 6787.796366109024, 6792.796216113525, 6912.827179320558, 6920.065791118134, 6167.0, 6275.748970041147, 6401.423871851555, 6476.093346931528, 6489.610623362613, 4583.564561366665, 4611.16998940194, 4616.630669546361, 4659.930101048555, 4734.4081989751285, 4645.3032045193495, 4735.360726302043, 4764.618830493621, 4844.0, 4868.756562171948], "value": 4188.955857316993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.64104715388686, 308.3109250824407, 315.26700421519956, 315.4086088583906, 318.91548739584, 4803.303520989454, 4848.442429120652, 4882.487338829425, 4909.239067944465, 4937.827176048834, 4792.6405519586, 4819.156647586676, 4820.831270905519, 4823.638227132961, 4864.708117512942, 3827.5981021992707, 3839.520059992501, 3844.2119365529998, 3848.7113466489986, 3848.8845334639864, 3810.180466454817, 3849.711271654623, 3851.4030325299623, 3870.2066076454257, 3871.0, 3749.700023998087, 3795.9810200948955, 3828.770273783568, 3837.5011248537653, 3847.461355410245, 3803.505544279226, 3818.1409182933894, 3827.9664490587666, 3832.540095188567, 3834.789086600236, 3398.1164897126678, 3423.5891692997, 3426.595096010624, 3438.209211881281, 3445.3453843769603, 4671.719696818168, 4681.752758675854, 4688.578027977498, 4710.293455981596, 4732.976335118303, 4074.2462644410584, 4248.235317642823, 4298.957010429887, 4323.459567554056, 4330.307150855848, 4989.875253118665, 5055.443901170868, 5059.2916991621205, 5065.544101030925, 5081.8475445736685, 3622.8913132606062, 3627.4740162676526, 3635.4910312556262, 3645.471406646048, 3652.7443078984484, 5005.947561499804, 5176.430592634807, 5224.425313215544, 5331.253624492574, 5347.171188465794, 3680.0, 3690.8523659053335, 3713.1274150574595, 3714.312852122366, 3719.9256014880093, 3780.584135745066, 3785.905352366158, 3786.9431958520095, 3788.2234142000825, 3789.810509474515, 4094.140230551558, 4160.958390416057, 4222.1766755483, 4244.384564238168, 4252.510961239435, 5006.6245031622775, 5060.696358218519, 5061.240813877874, 5061.949380506221, 5098.158803797406, 1290.664427248922, 1301.102239454773, 1309.1359702596242, 1318.162966516269, 1325.2578556008666, 828.8218033122907, 833.4332653795477, 842.1704620948361, 851.9531425771518, 864.3992425264381, 4064.6545043671617, 4077.1448990709155, 4077.347624380144, 4092.3247664135083, 4095.447114639545, 4628.195003948463, 4657.930131048037, 4668.8365907193765, 4671.369365135731, 4680.3915490985955, 4081.3469844824685, 4089.161721847014, 4092.3452247640234, 4103.097318589906, 4128.142335948835, 2319.884005799703, 2436.84160529565, 2478.3804048987754, 2484.4782595655115, 2490.7509249074947, 4403.722920353126, 4442.466903971479, 4447.909482543199, 4490.730556166641, 4499.820007199741, 4744.722533184091, 4761.809527618926, 4763.976180119077, 4795.808167673324, 4801.4718380978065, 4253.767865525359, 4341.327094300388, 4434.268345722984, 4437.378766972626, 4532.456105267257, 4674.906501870011, 4680.4149481314835, 4695.394056298787, 4715.646326525456, 4750.738709371018, 4694.06118776253, 4722.173619616622, 4948.777305021355, 4951.529604687549, 5110.693358398508, 4964.801407943642, 4975.378077740283, 4986.800527978985, 4990.700557966388, 4997.475265097258, 3619.2218672985437, 3621.4386770050683, 3632.8546858126438, 3633.109888077438, 3642.144096137353, 5073.8731531712, 5164.9741751291, 5183.352080989876, 5245.609913372883, 5282.366116065943, 5032.496750324938, 5035.395752509576, 5041.773120209526, 5061.974690126526, 5076.949230507647, 5031.874203144951, 5045.470225626404, 5061.367329083864, 5069.822556210515, 5071.290019397361, 4758.310045043519, 4975.353204083446, 4993.600511958962, 5030.798768049237, 5042.0, 5104.617153713412, 5113.897722045613, 5118.462561430996, 5128.974355128201, 5130.435652078194, 5010.899782004412, 5011.373578302712, 5024.472430394756, 5026.220935754964, 5029.5221953914315], "value": 3742.0291682346588, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.0193954219816, 647.1554621219307, 653.3466533466534, 662.4303099334575, 722.8698834209847, 11197.776044479106, 11712.355820429873, 12798.168119072254, 13266.800997985038, 13322.333883305844, 13558.796618050737, 13650.11274267172, 13658.180509169431, 13732.176069435816, 13736.58790236292, 688.1432616392598, 843.1147295339899, 868.7263511993733, 869.9782505437352, 878.3500209844701, 853.6158728572136, 853.8889944307232, 854.8888644476209, 856.8200677857626, 857.3741168946673, 897.3718397122008, 908.7773495493614, 910.1535571918114, 910.9954450227773, 911.3757076402652, 708.6846353372752, 883.2933653077577, 897.1701176411825, 906.7823722306599, 907.2152588011388, 665.3778716899666, 669.3875104279579, 670.8993650952348, 671.0571646836203, 671.3554987212282, 11260.380679062648, 11265.493052812642, 11304.37825919574, 11310.264832785924, 11312.717182070432, 10863.293885897392, 11309.095272378272, 11465.254758440758, 11503.654890353302, 11742.236754610924, 10871.29336593119, 10928.289661172077, 11011.0, 11023.118150547936, 11185.105191584735, 4067.5729048449784, 4073.97963010186, 4143.751374917484, 4160.43834082398, 4181.435506206653, 46225.768871155764, 46281.0, 46734.29898551524, 46758.5324146761, 46902.2964655527, 9460.25476055093, 9472.194863436685, 9648.372855764354, 9782.315237933277, 10017.0, 16928.661426771396, 16943.576410589834, 16962.406315779135, 16964.575885602957, 16973.15134243283, 6254.405831446005, 6313.2424109107205, 6353.3329000455215, 6382.968085159545, 6540.9672951635885, 3646.5988741238443, 3648.562172539312, 3666.9861427259316, 3696.9815150924073, 3832.5784163741964, 2881.6109825173335, 2971.301744090137, 2975.8809647614285, 2985.358147998147, 2986.2385091801452, 469.7064334790756, 538.8518157506717, 541.5694522854341, 555.6832605414875, 566.3571845954871, 495.8165478772805, 502.2040066494647, 544.1375419959409, 550.8319962411503, 558.1432501110776, 7702.9229707703325, 8009.599520023976, 8051.436399451982, 8056.274935255738, 8224.095349511548, 492.99014019720124, 503.8715127642501, 539.5467807042025, 588.3116753398534, 592.1739173852452, 3583.7133029357587, 3651.8721844735305, 3692.9446058309145, 3694.131879008431, 3752.0350906891003, 59064.0, 59278.0, 59480.405195948355, 60098.0, 60403.0, 52947.205791913155, 53327.0, 53377.46622533802, 53383.0, 55026.39683238037, 48485.0, 48529.514704852496, 49585.25622115671, 49759.502404976214, 51312.74343628258, 7070.4343652508705, 7144.857102858018, 7199.820004499929, 7378.704851805867, 7415.740449084256, 32250.838745806122, 32251.0, 32565.34869302553, 32825.50761738623, 33321.83339083289, 39031.804840975616, 42563.7871810639, 42900.0, 43497.56502435062, 43535.0, 9582.329236953346, 9694.5152742364, 9710.0, 9810.166135878244, 9868.013198680075, 10373.273870828969, 10514.947425262824, 10522.21083418762, 10888.782224355627, 10929.617463388744, 8695.565221738761, 9625.614975400906, 9766.121049105615, 9793.559289831832, 9937.65218217359, 9291.21024712907, 9454.574544145667, 9523.525553104086, 9708.708738737849, 9709.6601618943, 9277.304202184729, 9433.386829856037, 9455.290853185901, 9610.711678649652, 9783.60865565398, 7618.352440042659, 7646.617669116411, 7754.651040703069, 7760.767176984699, 8105.594720264081, 8058.798530036796, 8075.798105047421, 8160.306373958043, 8326.791830204293, 8416.032156302104], "value": 5894.407154839606, "unit": "score"}], "name": "dromaeo_css", "value": 6295.035295457992, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 113.0, 114.0, 112.0, 112.0, 113.0, 111.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 156.0, 235.0, 127.0, 154.0, 159.0, 130.0, 190.0, 128.0], "value": 156.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 161.0, 163.0, 162.0, 162.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 155.0, 77.0, 75.0, 77.0, 76.0, 133.0, 75.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 152.0, 93.0, 93.0, 92.0, 135.0, 92.0, 91.0, 121.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 118.0, 119.0, 119.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 82.0, 84.0, 84.0, 83.0, 84.0, 147.0, 82.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 138.0, 142.0, 131.0, 130.0, 130.0, 134.0, 129.0, 153.0, 130.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 173.0, 170.0, 172.0, 168.0, 166.0, 166.0, 170.0, 165.0, 165.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 64.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1572.7000000000003, "alertThreshold": 2.0}]} 10:28:15 INFO - Return code: 0 10:28:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:28:15 ERROR - # TBPL SUCCESS # 10:28:15 INFO - Running post-action listener: _resource_record_post_action 10:28:15 INFO - ##### 10:28:15 INFO - ##### Finished run-tests step (success) 10:28:15 INFO - ##### 10:28:15 INFO - Running post-run listener: _resource_record_post_run 10:28:15 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 309194752; Read time: 0; Write time: 234316 10:28:15 INFO - TinderboxPrint: CPU usage
13.2% 10:28:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:28:15 INFO - TinderboxPrint: I/O write bytes / time
309,194,752 / 234,316 10:28:15 INFO - TinderboxPrint: CPU idle
8,321.5 (86.8%) 10:28:15 INFO - TinderboxPrint: CPU user
1,221.0 (12.7%) 10:28:15 INFO - TinderboxPrint: Swap in / out
0 / 0 10:28:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20000768; Read time: 0; Write time: 9844 10:28:15 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 289193984; Read time: 0; Write time: 224472 10:28:16 INFO - Running post-run listener: _upload_blobber_files 10:28:16 INFO - Blob upload gear active. 10:28:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:28:16 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 10:28:16 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:28:16 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:28:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:28:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:17 INFO - (blobuploader) - INFO - Done attempting. 10:28:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:28:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:18 INFO - (blobuploader) - INFO - Done attempting. 10:28:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:28:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:28:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:22 INFO - (blobuploader) - INFO - Done attempting. 10:28:22 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:22 INFO - Return code: 0 10:28:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6e468fcec12449be700c7b29ae972b993ef0c95c7c35c0f292e026ca01b465cddad3d712a92a1fd730069c2c4c96a5c915779d7f2a0c0222dc07d74a30629e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40d5d8cd954916603971bfc33e5b556edd67984a0e6376c3dd248f681473a613f8e3a9d65a51ded713eabb7fb9e3844bc874dd4aeeefee704e0825ac9c7c742d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3330a5e2fda9d00b1a6181451a12e13f2ce014f470f7bcac4b327028df118977ead3a29475982b0f86415fa069250eb6d39653af9c2e3ec712639c7075055005"} 10:28:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:22 INFO - Contents: 10:28:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6e468fcec12449be700c7b29ae972b993ef0c95c7c35c0f292e026ca01b465cddad3d712a92a1fd730069c2c4c96a5c915779d7f2a0c0222dc07d74a30629e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40d5d8cd954916603971bfc33e5b556edd67984a0e6376c3dd248f681473a613f8e3a9d65a51ded713eabb7fb9e3844bc874dd4aeeefee704e0825ac9c7c742d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3330a5e2fda9d00b1a6181451a12e13f2ce014f470f7bcac4b327028df118977ead3a29475982b0f86415fa069250eb6d39653af9c2e3ec712639c7075055005"} 10:28:22 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:22 INFO - Copying logs to upload dir... 10:28:22 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.260477 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-05-18 10:28:21.397964) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 10:28:21.401090) ========= 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=0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6e468fcec12449be700c7b29ae972b993ef0c95c7c35c0f292e026ca01b465cddad3d712a92a1fd730069c2c4c96a5c915779d7f2a0c0222dc07d74a30629e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40d5d8cd954916603971bfc33e5b556edd67984a0e6376c3dd248f681473a613f8e3a9d65a51ded713eabb7fb9e3844bc874dd4aeeefee704e0825ac9c7c742d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3330a5e2fda9d00b1a6181451a12e13f2ce014f470f7bcac4b327028df118977ead3a29475982b0f86415fa069250eb6d39653af9c2e3ec712639c7075055005"} build_url:https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/d0kaMEviRb61dqhFXB5iHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b6e468fcec12449be700c7b29ae972b993ef0c95c7c35c0f292e026ca01b465cddad3d712a92a1fd730069c2c4c96a5c915779d7f2a0c0222dc07d74a30629e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40d5d8cd954916603971bfc33e5b556edd67984a0e6376c3dd248f681473a613f8e3a9d65a51ded713eabb7fb9e3844bc874dd4aeeefee704e0825ac9c7c742d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3330a5e2fda9d00b1a6181451a12e13f2ce014f470f7bcac4b327028df118977ead3a29475982b0f86415fa069250eb6d39653af9c2e3ec712639c7075055005"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 10:28:21.428883) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 10:28:21.429202) ========= 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=0e2a256762fed810e2f0f810000001b3-1463591245.806538-2128519891 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 10:28:21.515432) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 10:28:21.515803) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 10:28:21.516068) ========= ========= Total master_lag: 0.17 =========