builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-062 starttime: 1463543732.96 results: success (0) buildid: 20160517202150 builduid: 4378b79e52154501b1f0e587529d1e65 revision: d81b1964bb6b4ae973597d3fafa71dd962f2040b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:32.959836) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:32.960219) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:32.960507) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.025659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.025920) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 20:55:33-- 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% 114M=0s 2016-05-17 20:55:33 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137235 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.176236) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.176558) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.225945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.226255) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d81b1964bb6b4ae973597d3fafa71dd962f2040b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d81b1964bb6b4ae973597d3fafa71dd962f2040b --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=a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 20:55:33,353 truncating revision to first 12 chars 2016-05-17 20:55:33,353 Setting DEBUG logging. 2016-05-17 20:55:33,353 attempt 1/10 2016-05-17 20:55:33,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d81b1964bb6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 20:55:33,617 unpacking tar archive at: fx-team-d81b1964bb6b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.778378) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.778679) ========= script_repo_revision: d81b1964bb6b4ae973597d3fafa71dd962f2040b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.779081) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.779348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 20:55:33.787583) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-17 20:55:33.787852) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:55:33 INFO - MultiFileLogger online at 20160517 20:55:33 in /builds/slave/test 20:55:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:55:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:55:34 INFO - {'append_to_log': False, 20:55:34 INFO - 'base_work_dir': '/builds/slave/test', 20:55:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:55:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:55:34 INFO - 'branch': 'Fx-Team-Non-PGO', 20:55:34 INFO - 'buildbot_json_path': 'buildprops.json', 20:55:34 INFO - 'config_files': ('talos/linux_config.py',), 20:55:34 INFO - 'default_actions': ('clobber', 20:55:34 INFO - 'read-buildbot-config', 20:55:34 INFO - 'download-and-extract', 20:55:34 INFO - 'populate-webroot', 20:55:34 INFO - 'create-virtualenv', 20:55:34 INFO - 'install', 20:55:34 INFO - 'run-tests'), 20:55:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:55:34 INFO - 'download_minidump_stackwalk': True, 20:55:34 INFO - 'download_symbols': 'ondemand', 20:55:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:55:34 INFO - 'tooltool.py': '/tools/tooltool.py', 20:55:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:55:34 INFO - '/tools/misc-python/virtualenv.py')}, 20:55:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:55:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:55:34 INFO - 'installer_path': 'installer.exe', 20:55:34 INFO - 'log_level': 'info', 20:55:34 INFO - 'log_name': 'talos', 20:55:34 INFO - 'log_to_console': True, 20:55:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:55:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:55:34 INFO - 'opt_config_files': (), 20:55:34 INFO - 'pip_index': False, 20:55:34 INFO - 'sps_profile': False, 20:55:34 INFO - 'sps_profile_interval': 0, 20:55:34 INFO - 'suite': 'dromaeojs', 20:55:34 INFO - 'system_bits': '32', 20:55:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:55:34 INFO - 'title': 'talos-linux64-ix-062', 20:55:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:55:34 INFO - 'use_talos_json': True, 20:55:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:55:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:55:34 INFO - 'work_dir': 'build'} 20:55:34 INFO - ##### 20:55:34 INFO - ##### Running clobber step. 20:55:34 INFO - ##### 20:55:34 INFO - Running pre-action listener: _resource_record_pre_action 20:55:34 INFO - Running main action method: clobber 20:55:34 INFO - rmtree: /builds/slave/test/build 20:55:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:55:34 INFO - Running post-action listener: _resource_record_post_action 20:55:34 INFO - ##### 20:55:34 INFO - ##### Finished clobber step (success) 20:55:34 INFO - ##### 20:55:34 INFO - ##### 20:55:34 INFO - ##### Running read-buildbot-config step. 20:55:34 INFO - ##### 20:55:34 INFO - Running pre-action listener: _resource_record_pre_action 20:55:34 INFO - Running main action method: read_buildbot_config 20:55:34 INFO - Using buildbot properties: 20:55:34 INFO - { 20:55:34 INFO - "project": "", 20:55:34 INFO - "product": "firefox", 20:55:34 INFO - "script_repo_revision": "production", 20:55:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:55:34 INFO - "repository": "", 20:55:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:55:34 INFO - "buildid": "20160517202150", 20:55:34 INFO - "pgo_build": "False", 20:55:34 INFO - "basedir": "/builds/slave/test", 20:55:34 INFO - "buildnumber": 1693, 20:55:34 INFO - "slavename": "talos-linux64-ix-062", 20:55:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:55:34 INFO - "platform": "ubuntu64_hw", 20:55:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:55:34 INFO - "branch": "fx-team", 20:55:34 INFO - "repo_path": "integration/fx-team", 20:55:34 INFO - "revision": "d81b1964bb6b4ae973597d3fafa71dd962f2040b", 20:55:34 INFO - "stage_platform": "linux64", 20:55:34 INFO - "builduid": "4378b79e52154501b1f0e587529d1e65", 20:55:34 INFO - "slavebuilddir": "test" 20:55:34 INFO - } 20:55:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:55:34 INFO - Running post-action listener: _resource_record_post_action 20:55:34 INFO - ##### 20:55:34 INFO - ##### Finished read-buildbot-config step (success) 20:55:34 INFO - ##### 20:55:34 INFO - ##### 20:55:34 INFO - ##### Running download-and-extract step. 20:55:34 INFO - ##### 20:55:34 INFO - Running pre-action listener: _resource_record_pre_action 20:55:34 INFO - Running main action method: download_and_extract 20:55:34 INFO - mkdir: /builds/slave/test/build/tests 20:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:34 INFO - https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:55:39 INFO - Downloaded 1361 bytes. 20:55:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:55:39 INFO - Using the following test package requirements: 20:55:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:55:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:55:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:55:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:39 INFO - u'jsshell-linux-x86_64.zip'], 20:55:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:55:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:55:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:55:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:55:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:55:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:55:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:55:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:39 INFO - https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:55:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:55:41 INFO - Downloaded 22489217 bytes. 20:55:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:55:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:55:42 INFO - Return code: 0 20:55:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:42 INFO - https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:55:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:55:47 INFO - Downloaded 22489217 bytes. 20:55:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:55:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:55:48 INFO - Return code: 0 20:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:48 INFO - https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:55:49 INFO - Downloaded 10840194 bytes. 20:55:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:55:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:55:49 INFO - Return code: 0 20:55: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')]} 20:55:49 INFO - https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:55:51 INFO - Downloaded 54777182 bytes. 20:55:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:51 INFO - mkdir: /builds/slave/test/properties 20:55:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:55:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:55:51 INFO - Contents: 20:55:51 INFO - build_url:https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:52 INFO - Running post-action listener: _resource_record_post_action 20:55:52 INFO - Running post-action listener: set_extra_try_arguments 20:55:52 INFO - ##### 20:55:52 INFO - ##### Finished download-and-extract step (success) 20:55:52 INFO - ##### 20:55:52 INFO - ##### 20:55:52 INFO - ##### Running populate-webroot step. 20:55:52 INFO - ##### 20:55:52 INFO - Running pre-action listener: _resource_record_pre_action 20:55:52 INFO - Running main action method: populate_webroot 20:55:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:55:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:55:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:55:52 INFO - '--tppagecycles', 20:55:52 INFO - '7'], 20:55:52 INFO - 'tests': ['tsvgm']}}, 20:55:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:55:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:55:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:55:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:55:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:52 INFO - 'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:55:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:55:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:52 INFO - 'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['damp', 'tps']}, 20:55:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:52 INFO - 'tests': ['damp', 'tps']}, 20:55:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['dromaeo_dom']}, 20:55:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:55:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['a11yr', 20:55:52 INFO - 'ts_paint', 20:55:52 INFO - 'tpaint', 20:55:52 INFO - 'sessionrestore', 20:55:52 INFO - 'sessionrestore_no_auto_restore', 20:55:52 INFO - 'tabpaint']}, 20:55:52 INFO - 'other-e10s': {'tests': ['a11yr', 20:55:52 INFO - 'ts_paint', 20:55:52 INFO - 'tpaint', 20:55:52 INFO - 'sessionrestore', 20:55:52 INFO - 'sessionrestore_no_auto_restore', 20:55:52 INFO - 'tabpaint']}, 20:55:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:55:52 INFO - 'ts_paint', 20:55:52 INFO - 'tpaint', 20:55:52 INFO - 'sessionrestore', 20:55:52 INFO - 'sessionrestore_no_auto_restore', 20:55:52 INFO - 'tabpaint']}, 20:55:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:55:52 INFO - 'ts_paint', 20:55:52 INFO - 'tpaint', 20:55:52 INFO - 'sessionrestore', 20:55:52 INFO - 'sessionrestore_no_auto_restore', 20:55:52 INFO - 'tabpaint']}, 20:55:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['a11yr', 20:55:52 INFO - 'ts_paint', 20:55:52 INFO - 'tpaint', 20:55:52 INFO - 'sessionrestore', 20:55:52 INFO - 'sessionrestore_no_auto_restore', 20:55:52 INFO - 'tabpaint']}, 20:55:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['a11yr', 20:55:52 INFO - 'ts_paint', 20:55:52 INFO - 'tpaint', 20:55:52 INFO - 'sessionrestore', 20:55:52 INFO - 'sessionrestore_no_auto_restore', 20:55:52 INFO - 'tabpaint']}, 20:55:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['tsvgx', 20:55:52 INFO - 'tsvgr_opacity', 20:55:52 INFO - 'tart', 20:55:52 INFO - 'tscrollx', 20:55:52 INFO - 'cart']}, 20:55:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:55:52 INFO - 'tsvgr_opacity', 20:55:52 INFO - 'tart', 20:55:52 INFO - 'tscrollx', 20:55:52 INFO - 'cart']}, 20:55:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:52 INFO - 'talos_options': ['--disable-e10s'], 20:55:52 INFO - 'tests': ['tp5o']}, 20:55:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:52 INFO - 'tests': ['tp5o']}, 20:55:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:52 INFO - 'talos_options': ['--disable-e10s', 20:55:52 INFO - '--xperf_path', 20:55:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:55:52 INFO - 'tests': ['tp5n']}, 20:55:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:52 INFO - 'talos_options': ['--xperf_path', 20:55:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:55:52 INFO - 'tests': ['tp5n']}}, 20:55:52 INFO - 'talos.zip': {'path': '', 20:55:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:55:52 INFO - Running post-action listener: _resource_record_post_action 20:55:52 INFO - ##### 20:55:52 INFO - ##### Finished populate-webroot step (success) 20:55:52 INFO - ##### 20:55:52 INFO - ##### 20:55:52 INFO - ##### Running create-virtualenv step. 20:55:52 INFO - ##### 20:55:52 INFO - Running pre-action listener: _resource_record_pre_action 20:55:52 INFO - Running main action method: create_virtualenv 20:55:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:55:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:55:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:55:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:55:52 INFO - Using real prefix '/usr' 20:55:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:55:53 INFO - Installing distribute.............................................................................................................................................................................................done. 20:55:55 INFO - Installing pip.................done. 20:55:55 INFO - Return code: 0 20:55:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:55:55 INFO - Using env: {'DISPLAY': ':0', 20:55:55 INFO - 'HOME': '/home/cltbld', 20:55:55 INFO - 'LANG': 'en_US.UTF-8', 20:55:55 INFO - 'LANGUAGE': 'en_US:en', 20:55:55 INFO - 'LOGNAME': 'cltbld', 20:55:55 INFO - 'MAIL': '/var/mail/cltbld', 20:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:55 INFO - 'MOZ_NO_REMOTE': '1', 20:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:55 INFO - 'NO_EM_RESTART': '1', 20:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:55:55 INFO - 'PWD': '/builds/slave/test', 20:55:55 INFO - 'SHELL': '/bin/bash', 20:55:55 INFO - 'SHLVL': '1', 20:55:55 INFO - 'TERM': 'linux', 20:55:55 INFO - 'TMOUT': '86400', 20:55:55 INFO - 'USER': 'cltbld', 20:55:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:55 INFO - '_': '/tools/buildbot/bin/python'} 20:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:55:55 INFO - Cleaning up... 20:55:55 INFO - Return code: 0 20:55:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:55:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:55:55 INFO - Using env: {'DISPLAY': ':0', 20:55:55 INFO - 'HOME': '/home/cltbld', 20:55:55 INFO - 'LANG': 'en_US.UTF-8', 20:55:55 INFO - 'LANGUAGE': 'en_US:en', 20:55:55 INFO - 'LOGNAME': 'cltbld', 20:55:55 INFO - 'MAIL': '/var/mail/cltbld', 20:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:55 INFO - 'MOZ_NO_REMOTE': '1', 20:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:55 INFO - 'NO_EM_RESTART': '1', 20:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:55:55 INFO - 'PWD': '/builds/slave/test', 20:55:55 INFO - 'SHELL': '/bin/bash', 20:55:55 INFO - 'SHLVL': '1', 20:55:55 INFO - 'TERM': 'linux', 20:55:55 INFO - 'TMOUT': '86400', 20:55:55 INFO - 'USER': 'cltbld', 20:55:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:55 INFO - '_': '/tools/buildbot/bin/python'} 20:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:55 INFO - Downloading/unpacking psutil>=3.1.1 20:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:55:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:55:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:55:57 INFO - Installing collected packages: psutil 20:55:57 INFO - Running setup.py install for psutil 20:55:57 INFO - building 'psutil._psutil_linux' extension 20:55:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:55:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:55:57 INFO - building 'psutil._psutil_posix' extension 20:55:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:55:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:55:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:55:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:55:58 INFO - Successfully installed psutil 20:55:58 INFO - Cleaning up... 20:55:58 INFO - Return code: 0 20:55:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:55:58 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 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:55:58 INFO - Using env: {'DISPLAY': ':0', 20:55:58 INFO - 'HOME': '/home/cltbld', 20:55:58 INFO - 'LANG': 'en_US.UTF-8', 20:55:58 INFO - 'LANGUAGE': 'en_US:en', 20:55:58 INFO - 'LOGNAME': 'cltbld', 20:55:58 INFO - 'MAIL': '/var/mail/cltbld', 20:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:55:58 INFO - 'MOZ_NO_REMOTE': '1', 20:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:55:58 INFO - 'NO_EM_RESTART': '1', 20:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:55:58 INFO - 'PWD': '/builds/slave/test', 20:55:58 INFO - 'SHELL': '/bin/bash', 20:55:58 INFO - 'SHLVL': '1', 20:55:58 INFO - 'TERM': 'linux', 20:55:58 INFO - 'TMOUT': '86400', 20:55:58 INFO - 'USER': 'cltbld', 20:55:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:55:58 INFO - '_': '/tools/buildbot/bin/python'} 20:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:55:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:55: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 20:56:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:56:00 INFO - Installing collected packages: mozsystemmonitor 20:56:00 INFO - Running setup.py install for mozsystemmonitor 20:56:00 INFO - Successfully installed mozsystemmonitor 20:56:00 INFO - Cleaning up... 20:56:00 INFO - Return code: 0 20:56:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:00 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 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:56:00 INFO - Using env: {'DISPLAY': ':0', 20:56:00 INFO - 'HOME': '/home/cltbld', 20:56:00 INFO - 'LANG': 'en_US.UTF-8', 20:56:00 INFO - 'LANGUAGE': 'en_US:en', 20:56:00 INFO - 'LOGNAME': 'cltbld', 20:56:00 INFO - 'MAIL': '/var/mail/cltbld', 20:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:00 INFO - 'MOZ_NO_REMOTE': '1', 20:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:00 INFO - 'NO_EM_RESTART': '1', 20:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:00 INFO - 'PWD': '/builds/slave/test', 20:56:00 INFO - 'SHELL': '/bin/bash', 20:56:00 INFO - 'SHLVL': '1', 20:56:00 INFO - 'TERM': 'linux', 20:56:00 INFO - 'TMOUT': '86400', 20:56:00 INFO - 'USER': 'cltbld', 20:56:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:00 INFO - '_': '/tools/buildbot/bin/python'} 20:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:56:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:56:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56:03 INFO - Downloading docopt-0.6.1.tar.gz 20:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:56:03 INFO - Installing collected packages: blobuploader, requests, docopt 20:56:03 INFO - Running setup.py install for blobuploader 20:56:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:56:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:56:03 INFO - Running setup.py install for requests 20:56:03 INFO - Running setup.py install for docopt 20:56:03 INFO - Successfully installed blobuploader requests docopt 20:56:03 INFO - Cleaning up... 20:56:04 INFO - Return code: 0 20:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:04 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 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:56:04 INFO - Using env: {'DISPLAY': ':0', 20:56:04 INFO - 'HOME': '/home/cltbld', 20:56:04 INFO - 'LANG': 'en_US.UTF-8', 20:56:04 INFO - 'LANGUAGE': 'en_US:en', 20:56:04 INFO - 'LOGNAME': 'cltbld', 20:56:04 INFO - 'MAIL': '/var/mail/cltbld', 20:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:04 INFO - 'MOZ_NO_REMOTE': '1', 20:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:04 INFO - 'NO_EM_RESTART': '1', 20:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:04 INFO - 'PWD': '/builds/slave/test', 20:56:04 INFO - 'SHELL': '/bin/bash', 20:56:04 INFO - 'SHLVL': '1', 20:56:04 INFO - 'TERM': 'linux', 20:56:04 INFO - 'TMOUT': '86400', 20:56:04 INFO - 'USER': 'cltbld', 20:56:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:04 INFO - '_': '/tools/buildbot/bin/python'} 20:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:04 INFO - Running setup.py (path:/tmp/pip-BAixel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:04 INFO - Running setup.py (path:/tmp/pip-8w3dBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:04 INFO - Running setup.py (path:/tmp/pip-PNktpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:04 INFO - Running setup.py (path:/tmp/pip-fCvd3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:04 INFO - Running setup.py (path:/tmp/pip-eyOtWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:04 INFO - Running setup.py (path:/tmp/pip-ZKG6vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:04 INFO - Running setup.py (path:/tmp/pip-KjWR_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:04 INFO - Running setup.py (path:/tmp/pip-dcfjPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:04 INFO - Running setup.py (path:/tmp/pip-HIFUd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:04 INFO - Running setup.py (path:/tmp/pip-lyCtXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:04 INFO - Running setup.py (path:/tmp/pip-3NHR3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:05 INFO - Running setup.py (path:/tmp/pip-xpZjTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:05 INFO - Running setup.py (path:/tmp/pip-XIOCoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:05 INFO - Running setup.py (path:/tmp/pip-GKXxcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:05 INFO - Running setup.py (path:/tmp/pip-PecnhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:05 INFO - Running setup.py (path:/tmp/pip-0UXXAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:05 INFO - Running setup.py (path:/tmp/pip-Bs7Q0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:56:05 INFO - Running setup.py install for manifestparser 20:56:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:56:05 INFO - Running setup.py install for mozcrash 20:56:05 INFO - Running setup.py install for mozdebug 20:56:05 INFO - Running setup.py install for mozdevice 20:56:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:56:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:56:05 INFO - Running setup.py install for mozfile 20:56:05 INFO - Running setup.py install for mozhttpd 20:56:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Running setup.py install for mozinfo 20:56:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Running setup.py install for mozInstall 20:56:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Running setup.py install for mozleak 20:56:06 INFO - Running setup.py install for mozlog 20:56:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Running setup.py install for moznetwork 20:56:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Running setup.py install for mozprocess 20:56:06 INFO - Running setup.py install for mozprofile 20:56:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Running setup.py install for mozrunner 20:56:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:56:06 INFO - Running setup.py install for mozscreenshot 20:56:07 INFO - Running setup.py install for moztest 20:56:07 INFO - Running setup.py install for mozversion 20:56:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:56:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:56:07 INFO - Cleaning up... 20:56:07 INFO - Return code: 0 20:56:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56: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')]} 20:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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')]} 20:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:07 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 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:56:07 INFO - Using env: {'DISPLAY': ':0', 20:56:07 INFO - 'HOME': '/home/cltbld', 20:56:07 INFO - 'LANG': 'en_US.UTF-8', 20:56:07 INFO - 'LANGUAGE': 'en_US:en', 20:56:07 INFO - 'LOGNAME': 'cltbld', 20:56:07 INFO - 'MAIL': '/var/mail/cltbld', 20:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:07 INFO - 'MOZ_NO_REMOTE': '1', 20:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:07 INFO - 'NO_EM_RESTART': '1', 20:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:07 INFO - 'PWD': '/builds/slave/test', 20:56:07 INFO - 'SHELL': '/bin/bash', 20:56:07 INFO - 'SHLVL': '1', 20:56:07 INFO - 'TERM': 'linux', 20:56:07 INFO - 'TMOUT': '86400', 20:56:07 INFO - 'USER': 'cltbld', 20:56:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:07 INFO - '_': '/tools/buildbot/bin/python'} 20:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:07 INFO - Running setup.py (path:/tmp/pip-6nMiSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:07 INFO - Running setup.py (path:/tmp/pip-N8xSeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:07 INFO - Running setup.py (path:/tmp/pip-E6Tf3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:07 INFO - Running setup.py (path:/tmp/pip-rUzdVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:07 INFO - Running setup.py (path:/tmp/pip-F6O2O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:07 INFO - Running setup.py (path:/tmp/pip-aZMvZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:07 INFO - Running setup.py (path:/tmp/pip-9x9TIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:07 INFO - Running setup.py (path:/tmp/pip-0iwvx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:08 INFO - Running setup.py (path:/tmp/pip-zW92RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:08 INFO - Running setup.py (path:/tmp/pip-gERr52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:08 INFO - Running setup.py (path:/tmp/pip-semOWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:08 INFO - Running setup.py (path:/tmp/pip-5xGR9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:08 INFO - Running setup.py (path:/tmp/pip-f1IZG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:08 INFO - Running setup.py (path:/tmp/pip-DOeMQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:08 INFO - Running setup.py (path:/tmp/pip-T2uENy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:08 INFO - Running setup.py (path:/tmp/pip-kepeD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:08 INFO - Running setup.py (path:/tmp/pip-a9p0xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:56:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:10 INFO - Downloading blessings-1.6.tar.gz 20:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:56:10 INFO - Installing collected packages: blessings 20:56:10 INFO - Running setup.py install for blessings 20:56:10 INFO - Successfully installed blessings 20:56:10 INFO - Cleaning up... 20:56:10 INFO - Return code: 0 20:56:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:56:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:11 INFO - Reading from file tmpfile_stdout 20:56:11 INFO - Current package versions: 20:56:11 INFO - argparse == 1.2.1 20:56:11 INFO - blessings == 1.6 20:56:11 INFO - blobuploader == 1.2.4 20:56:11 INFO - docopt == 0.6.1 20:56:11 INFO - manifestparser == 1.1 20:56:11 INFO - mozInstall == 1.12 20:56:11 INFO - mozcrash == 0.17 20:56:11 INFO - mozdebug == 0.1 20:56:11 INFO - mozdevice == 0.48 20:56:11 INFO - mozfile == 1.2 20:56:11 INFO - mozhttpd == 0.7 20:56:11 INFO - mozinfo == 0.9 20:56:11 INFO - mozleak == 0.1 20:56:11 INFO - mozlog == 3.2 20:56:11 INFO - moznetwork == 0.27 20:56:11 INFO - mozprocess == 0.22 20:56:11 INFO - mozprofile == 0.28 20:56:11 INFO - mozrunner == 6.11 20:56:11 INFO - mozscreenshot == 0.1 20:56:11 INFO - mozsystemmonitor == 0.3 20:56:11 INFO - moztest == 0.7 20:56:11 INFO - mozversion == 1.4 20:56:11 INFO - psutil == 3.1.1 20:56:11 INFO - requests == 1.2.3 20:56:11 INFO - wsgiref == 0.1.2 20:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:11 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 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:56:11 INFO - Using env: {'DISPLAY': ':0', 20:56:11 INFO - 'HOME': '/home/cltbld', 20:56:11 INFO - 'LANG': 'en_US.UTF-8', 20:56:11 INFO - 'LANGUAGE': 'en_US:en', 20:56:11 INFO - 'LOGNAME': 'cltbld', 20:56:11 INFO - 'MAIL': '/var/mail/cltbld', 20:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:11 INFO - 'MOZ_NO_REMOTE': '1', 20:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:11 INFO - 'NO_EM_RESTART': '1', 20:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:11 INFO - 'PWD': '/builds/slave/test', 20:56:11 INFO - 'SHELL': '/bin/bash', 20:56:11 INFO - 'SHLVL': '1', 20:56:11 INFO - 'TERM': 'linux', 20:56:11 INFO - 'TMOUT': '86400', 20:56:11 INFO - 'USER': 'cltbld', 20:56:11 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:11 INFO - '_': '/tools/buildbot/bin/python'} 20:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:56:11 INFO - Cleaning up... 20:56:11 INFO - Return code: 0 20:56:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:11 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 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:56:11 INFO - Using env: {'DISPLAY': ':0', 20:56:11 INFO - 'HOME': '/home/cltbld', 20:56:11 INFO - 'LANG': 'en_US.UTF-8', 20:56:11 INFO - 'LANGUAGE': 'en_US:en', 20:56:11 INFO - 'LOGNAME': 'cltbld', 20:56:11 INFO - 'MAIL': '/var/mail/cltbld', 20:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:11 INFO - 'MOZ_NO_REMOTE': '1', 20:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:11 INFO - 'NO_EM_RESTART': '1', 20:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:11 INFO - 'PWD': '/builds/slave/test', 20:56:11 INFO - 'SHELL': '/bin/bash', 20:56:11 INFO - 'SHLVL': '1', 20:56:11 INFO - 'TERM': 'linux', 20:56:11 INFO - 'TMOUT': '86400', 20:56:11 INFO - 'USER': 'cltbld', 20:56:11 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:11 INFO - '_': '/tools/buildbot/bin/python'} 20:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:11 INFO - Downloading/unpacking jsonschema 20:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:56:13 INFO - Downloading/unpacking functools32 (from jsonschema) 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56: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 20:56:13 INFO - Downloading functools32-3.2.3-2.tar.gz 20:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:56:13 INFO - warning: no files found matching '*.txt' 20:56:13 INFO - no previously-included directories found matching 'build' 20:56:13 INFO - no previously-included directories found matching 'dist' 20:56:13 INFO - no previously-included directories found matching '.git*' 20:56:13 INFO - Installing collected packages: jsonschema, functools32 20:56:13 INFO - Running setup.py install for functools32 20:56:13 INFO - warning: no files found matching '*.txt' 20:56:13 INFO - no previously-included directories found matching 'build' 20:56:13 INFO - no previously-included directories found matching 'dist' 20:56:13 INFO - no previously-included directories found matching '.git*' 20:56:13 INFO - Successfully installed jsonschema functools32 20:56:13 INFO - Cleaning up... 20:56:13 INFO - Return code: 0 20:56:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:13 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 0x7f935312df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2158770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:56:13 INFO - Using env: {'DISPLAY': ':0', 20:56:13 INFO - 'HOME': '/home/cltbld', 20:56:13 INFO - 'LANG': 'en_US.UTF-8', 20:56:13 INFO - 'LANGUAGE': 'en_US:en', 20:56:13 INFO - 'LOGNAME': 'cltbld', 20:56:13 INFO - 'MAIL': '/var/mail/cltbld', 20:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:13 INFO - 'MOZ_NO_REMOTE': '1', 20:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:13 INFO - 'NO_EM_RESTART': '1', 20:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:13 INFO - 'PWD': '/builds/slave/test', 20:56:13 INFO - 'SHELL': '/bin/bash', 20:56:13 INFO - 'SHLVL': '1', 20:56:13 INFO - 'TERM': 'linux', 20:56:13 INFO - 'TMOUT': '86400', 20:56:13 INFO - 'USER': 'cltbld', 20:56:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:13 INFO - '_': '/tools/buildbot/bin/python'} 20:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:14 INFO - Downloading/unpacking flake8 20:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:56:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:56:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:56:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:56:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:56:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:56:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:56:16 INFO - no previously-included directories found matching 'docs/_build' 20:56:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:56:16 INFO - Running setup.py install for pep8 20:56:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:56:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:56:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:56:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:56:16 INFO - no previously-included directories found matching 'docs/_build' 20:56:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:56:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:56:16 INFO - Cleaning up... 20:56:16 INFO - Return code: 0 20:56:16 INFO - Running post-action listener: _resource_record_post_action 20:56:16 INFO - Running post-action listener: _start_resource_monitoring 20:56:16 INFO - Starting resource monitoring. 20:56:16 INFO - ##### 20:56:16 INFO - ##### Finished create-virtualenv step (success) 20:56:16 INFO - ##### 20:56:16 INFO - ##### 20:56:16 INFO - ##### Running install step. 20:56:16 INFO - ##### 20:56:16 INFO - Running pre-action listener: _resource_record_pre_action 20:56:16 INFO - Running main action method: install 20:56:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:17 INFO - Reading from file tmpfile_stdout 20:56:17 INFO - Detecting whether we're running mozinstall >=1.0... 20:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:56:17 INFO - Reading from file tmpfile_stdout 20:56:17 INFO - Output received: 20:56:17 INFO - Usage: mozinstall [options] installer 20:56:17 INFO - Options: 20:56:17 INFO - -h, --help show this help message and exit 20:56:17 INFO - -d DEST, --destination=DEST 20:56:17 INFO - Directory to install application into. [default: 20:56:17 INFO - "/builds/slave/test"] 20:56:17 INFO - --app=APP Application being installed. [default: firefox] 20:56:17 INFO - mkdir: /builds/slave/test/build/application 20:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:56:33 INFO - Reading from file tmpfile_stdout 20:56:33 INFO - Output received: 20:56:33 INFO - /builds/slave/test/build/application/firefox/firefox 20:56:33 INFO - Running post-action listener: _resource_record_post_action 20:56:33 INFO - ##### 20:56:33 INFO - ##### Finished install step (success) 20:56:33 INFO - ##### 20:56:33 INFO - ##### 20:56:33 INFO - ##### Running run-tests step. 20:56:33 INFO - ##### 20:56:33 INFO - Running pre-action listener: _resource_record_pre_action 20:56:33 INFO - Running main action method: run_tests 20:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:56:33 INFO - Python 2.7.3 20:56:33 INFO - Return code: 0 20:56:33 INFO - grabbing minidump binary from tooltool 20:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:33 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 0x21e79c0>, '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 0x21e88c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e8d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:56:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:56:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:56:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:56:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:56:33 INFO - Return code: 0 20:56:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:56:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:56:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:56:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:56:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:56:34 INFO - Return code: 0 20:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:56:34 INFO - Using env: {'DISPLAY': ':0', 20:56:34 INFO - 'HOME': '/home/cltbld', 20:56:34 INFO - 'LANG': 'en_US.UTF-8', 20:56:34 INFO - 'LANGUAGE': 'en_US:en', 20:56:34 INFO - 'LOGNAME': 'cltbld', 20:56:34 INFO - 'MAIL': '/var/mail/cltbld', 20:56:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:56:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:34 INFO - 'MOZ_NO_REMOTE': '1', 20:56:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:34 INFO - 'NO_EM_RESTART': '1', 20:56:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:34 INFO - 'PWD': '/builds/slave/test', 20:56:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:56:34 INFO - 'SHELL': '/bin/bash', 20:56:34 INFO - 'SHLVL': '1', 20:56:34 INFO - 'TERM': 'linux', 20:56:34 INFO - 'TMOUT': '86400', 20:56:34 INFO - 'USER': 'cltbld', 20:56:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030', 20:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:34 INFO - '_': '/tools/buildbot/bin/python'} 20:56:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:56:34 INFO - mozversion application_buildid: 20160517202150 20:56:34 INFO - mozversion application_changeset: d81b1964bb6b4ae973597d3fafa71dd962f2040b 20:56:34 INFO - mozversion application_display_name: Nightly 20:56:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:56:34 INFO - mozversion application_name: Firefox 20:56:34 INFO - mozversion application_remotingname: firefox 20:56:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:56:34 INFO - mozversion application_vendor: Mozilla 20:56:34 INFO - mozversion application_version: 49.0a1 20:56:34 INFO - mozversion platform_buildid: 20160517202150 20:56:34 INFO - mozversion platform_changeset: d81b1964bb6b4ae973597d3fafa71dd962f2040b 20:56:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:56:34 INFO - mozversion platform_version: 49.0a1 20:56:34 INFO - using testdate: 1463543794 20:56:34 INFO - actual date: 1463543794 20:56:34 INFO - starting webserver on 'localhost:57899' 20:56:34 INFO - SUITE-START | Running 2 tests 20:56:34 INFO - TEST-START | dromaeo_css 20:56:34 INFO - operating with platform_type : linux_ 20:56:34 INFO - Initialising browser for dromaeo_css test... 20:56:34 INFO - TEST-INFO | started process 8740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibJ7XB/profile http://localhost:57899/getInfo.html) 20:56:38 INFO - PROCESS | 8740 | __metrics Screen width/height:1600/1200 20:56:38 INFO - PROCESS | 8740 | colorDepth:24 20:56:38 INFO - PROCESS | 8740 | Browser inner width/height: 1024/697 20:56:38 INFO - PROCESS | 8740 | __metrics 20:56:38 ERROR - PROCESS | 8740 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:56:39 INFO - TEST-INFO | 8740: exit 0 20:56:39 INFO - Browser initialized. 20:56:39 INFO - Running cycle 1/1 for dromaeo_css test... 20:56:39 INFO - TEST-INFO | started process 8819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibJ7XB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:56:51 INFO - PROCESS | 8819 | RSS: Main: 154673152 20:56:51 INFO - PROCESS | 8819 | 20:57:42 INFO - PROCESS | 8819 | 1463543862838 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:59:55 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:57899/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57899/tests/dromaeo/cssquery-ext.html) 20:59:56 INFO - PROCESS | 8819 | RSS: Main: 256544768 20:59:56 INFO - PROCESS | 8819 | 21:02:59 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:57899/tests/dromaeo/cssquery-ext.html (next: http://localhost:57899/tests/dromaeo/cssquery-jquery.html) 21:03:00 INFO - PROCESS | 8819 | RSS: Main: 243802112 21:03:00 INFO - PROCESS | 8819 | 21:06:02 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:57899/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57899/tests/dromaeo/cssquery-mootools.html) 21:06:02 INFO - PROCESS | 8819 | RSS: Main: 243245056 21:06:02 INFO - PROCESS | 8819 | 21:09:05 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:57899/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57899/tests/dromaeo/cssquery-prototype.html) 21:09:05 INFO - PROCESS | 8819 | RSS: Main: 235192320 21:09:05 INFO - PROCESS | 8819 | 21:12:08 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:57899/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57899/tests/dromaeo/cssquery-yui.html) 21:12:09 INFO - PROCESS | 8819 | RSS: Main: 217714688 21:12:09 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | Cycle 1(1): loaded http://localhost:57899/tests/dromaeo/cssquery-yui.html (next: http://localhost:57899/tests/dromaeo/cssquery-dojo.html) 21:15:12 INFO - PROCESS | 8819 | RSS: Main: 269524992 21:15:12 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | __start_tp_report 21:15:12 INFO - PROCESS | 8819 | _x_x_mozilla_page_load 21:15:12 INFO - PROCESS | 8819 | _x_x_mozilla_page_load_details 21:15:12 INFO - PROCESS | 8819 | |i|pagename|runs| 21:15:12 INFO - PROCESS | 8819 | |0;dojo.html;2673.2381271337667;2690.852003139829;2715.158300926713;2731.63122978398;2736.7263273672634;4690.788914498848;4741.64437667175;4760.452547956986;4814.614830813535;4866.635002374823;4732.408448943882;4753.524647535245;4786.83246086387;4838.34682317887;4838.588719958808;4227.534971153171;4356.7821608919585;4454.487733910593;4475.082608065355;4598.494165641777;4480.820767169325;4513.571210734975;4534.8639540813665;4539.160255352754;4582.060677561109;4299.226139294926;4349.630281426051;4356.586124318184;4403.537628548988;4403.779811009436;4387.934180987256;4409.0520538084465;4457.866264012085;4461.888452788674;4466.665000125004;4427.977860110679;4437.733735975819;4451.065276291983;4478.193925093482;4488.798004089824;4561.452625684906;4655.86032419028;4752.5247475252545;4756.881077973044;4782.784774685113;5138.974305128488;5141.871453213699;5175.327207463043;5200.453952334989;5220.947790522084;4986.301917731521;5162.767675454614;5188.688678679254;5203.765830537597;5260.053190425722;4742.50203728607;4868.610511159099;4875.317455556225;4917.606591472673;4941.728204948762;5377.112776391929;5405.162199859028;5405.297311349499;5414.918776218281;5428.185772134132;4891.2174052152195;5087.8982420351385;5145.408278048072;5149.227615857576;5159.690418574897;5060.962502686941;5104.132297509433;5111.923321150111;5194.818181363634;5201.375834899836;5089.720065396439;5089.847304580869;5096.745162741922;5098.1842905135;5139.408967968731;5069;5077.644564880423;5078.187490001582;5085.516875896784;5085.898282034339;4260.829566817354;4296.2911119664905;4296.978515107405;4302.827886884552;4348.5216626171095;3770.849166033383;3804.0489877530617;3805.1818858945458;3812.1041555234497;3816.7900765458166;4427.911441771146;4429.313456414261;4430.933535996963;4461.08547747711;4473.821047158142;5129.281900533928;5142.61430392722;5144.074066668036;5144.485551444825;5145.974270128625;4295.72077814941;4353.064091220403;4410.492793328808;4431.4903786065015;4466.9106617867465;4694.43666759991;4705.623550115983;4708.152532544175;4734.431868175841;4744.715317080986;4890.364252647133;4930.383702037246;4933.58064564516;4946.480619534897;4985.675931064469;5044.9243261350375;5076.289319495199;5089.05852417304;5142.845714628567;5199.142141546602;4853.757312134449;4875.731834749123;4881.023795240895;4891.388576427947;4896.216605343128;5008.824691135793;5015.648904576645;5015.7492125392855;5018.723970181529;5060.797568097382;5020.949790502194;5136.383633963948;5160.509751573594;5167.844964651066;5202.0116177926075;5010.398752149766;5044.243363495359;5047.268146118866;5052.520010598987;5083.898322033612;4820.927686084641;4947.851564453073;4988.625853060962;4992.550670439678;5006.199008158823;4815.446223684181;4833.154198015403;4849.151398505318;4904.705717656952;4929.926051109164;4979.701217926936;4989.750512474289;4992.450830408579;5000.424951130666;5021.271915572294;4791.257355109963;4804.663673542818;4859.538343857328;4860.1008813369635;4902.166631672696 21:15:12 INFO - PROCESS | 8819 | |1;ext.html;565.3809079058432;601.4767152577258;607.6293460988793;608.6561092982467;612.4518555892477;28488.14535563934;42899;43894.780526097325;43958.340624890574;43962.7801860991;43631.34552981708;44359.77820110903;44455.77772111143;44505;44541.55458445415;7481.925180748177;7635.121960974476;7637.694492220305;7996.360291176721;8173.386995975296;7552.3202911737935;10095.242856785733;10319.742006449862;10335.069843714064;10605.628802991896;10321.380717156957;10399.584016639325;10420.895791042069;10436.478176091203;10444.738881527946;7560.168381478033;7748.263914928073;10226.744331391701;10297.073263406292;10303.690889273334;7630.198829122917;9479.383840050443;9647.421154730739;9668.274879384075;9689.418634881858;40471.392929105794;40594.79702601468;40903.38644920329;41045.384319235236;41074.178516429805;2966.2287805170595;3115.3302040061494;3149.622045354572;3152.4640811061945;3314.950275745866;29820.10539683813;29957;30057.398852022838;30608.2347941301;30619.08142755721;3378.2736711606876;3464.826758662057;3521.1197200699826;3548.8048157351336;3618.9866837285604;276633;278248;278736;279675;281670;59078.79672634397;59451;59512;59561;59668.70165649144;61321.641403031026;61519;61641;61672.691636542426;61794.69102654548;13716.245606491739;14093.71812563743;14104.647383815487;14110.22393768332;14118.85881141196;10409.167266618804;10464.52909619069;10506.684799456028;10640.84038739404;10768.838467422995;18644.533886652673;18774.249030038645;18809.811901880807;19457.22171113168;19487.123079461457;6997.440204783605;7084.149902011792;7145.8928116078305;7205.819854503679;7232.421406287484;842.3682238321259;885.9246964008003;927.3971918253054;961.274237950357;992.156666833186;29011;29517.557236641467;29577.704222957494;29579.26051848721;30050.398992020037;947.2706016367358;947.3510645208055;969.7236287658125;988.4069558265127;1075.6988043347876;15146.848531514765;15475.400089184055;15626.843731562767;15831.683366332609;15897.841021589637;435246;438605;439284;439729;440019;51494;51751;52066.73966630142;52256.47743522516;52409.47590524122;1142.6229344316355;1153.1754795321385;1188.9762204755684;1239.69007748063;1260.2249616485794;27452.588211177248;29855.10434686963;30319.848400757855;30673.53989690112;30712.385752285278;43597.782011089745;44159.33760993652;44164.55835441733;44197.779011104736;44306.335404968304;302991;306151;306272.1550314665;306680;306906;21408.57182856303;23644.881775591013;25784.484310314063;25850.870745646906;27018.1894543164;42709.78645106879;43064.569354306055;43375;44342;44364.33453498135;37367.252654946205;37504.81247593745;37561.81219093887;37905.4314185293;38155.2368952625;36071.27857442889;36393.09017274589;37138.44292335671;37445.81277093597;41034;37643.81178094092;37840.81079594584;38756.6124338753;38863;38892;33159.33681326408;34570.82714586411;34868.65131348654;34938.30123397569;35223.82388088043;25169.87415062913;26014.86992565025;26089.73910260873;26134.477310454065;26263.868680656473 21:15:12 INFO - PROCESS | 8819 | |2;jquery.html;387.3666555182277;389.31869228849513;390.33745302390435;393.3313367275632;404.8239016028028;12975.15661482003;13210.471581136768;16278.837211627895;17722.556936076606;17789.110544472773;16314.592135196626;16413.507594772145;16653.25060372283;17383.13084345784;17421.128943552805;5153.587712982952;5282.815101471449;5287.154055351145;5310.07073762092;5352.678839269637;5132.101882170624;5172.974135129338;5240.213967904807;5247.265382846385;5264.315638966929;5160.122779127557;5170.560502357304;5183.740812959356;5188.455212202721;5210.7655155517905;5073.213651883927;5100.438951715309;5180.818671346504;5201.115810312237;5205.843824685266;4617.630589552828;4626.375439315683;4633.745144017078;4647.047355292191;4690.202665546865;19651.705224421647;20675.483112922146;20848.47878803027;20929.372118836458;20950.37148885536;1959.6570600144917;1969.812867777559;1982.2071171531359;2026.4629873083645;2542.1992072497287;8735.34484913634;9153.99306076331;9383.390079644802;12550.68623284416;13659.248741319223;1717.6478821841492;1773.2906837265068;1809.9366522171792;1819.9818001819945;1823.772028496438;67906.3209367905;68732.96900546546;69216;69283.65358173176;71214;10125.240606954509;10178.847317290247;10197.592096316213;10313.948430257951;10404.063634272952;14341.211233382055;14412.567622971328;14433.494827680981;14466.638334041732;14473.638159045897;6894.689738961759;6908;7042.190148132928;7045.189803172599;7084.079069720903;6266.843328916813;6295.37046295376;6309.274433440121;6400.807975760735;6401.487880969511;4451.77741112943;4528.467795119812;4541.069080838421;4546.590806827401;4563.520830312836;1839.45736007878;1851.2502436513234;1856.860735444847;1858.0895361272878;1901.1349835824667;797.5533701127388;905.9954700226589;980.2794945714894;986.9883369546272;989.2432289298692;16243.187840607923;16986.405475808286;16994.150292485327;17270.22283997223;17725.379611713528;858.0689951402674;863.1799790199336;888.4624801994829;894.065701342099;967.6468089147411;8687.956560217159;9509.191718703849;9631.266372052958;9803.313768036169;9839.655612053544;373477;388864;397753;398927;401559;82833.58583207046;90702;91108.54445727862;91732.54133729289;92030.53984730167;962.8892677342195;969.709087273815;976.5019839881711;996.4170959988488;1010.2675560218782;15721.606959826096;15735.213239338216;15857.365705371656;16031.599210019844;16170.514884553482;32729;33854;39459.2108157841;39937;40190.1961960765;46820.531794681614;48426.27360589665;48791.75604121957;54977;55777.88444231012;7340.339369456775;7854;7959;7989.880151797612;8018.719344823136;8693.30453563726;11419.486123124645;11520.078393728649;11651.76696466049;11759.235649682743;9869.753256168653;10459.320144190604;10517.474126293502;10598.25812193139;10598.947005264925;10273.280870339304;10454.790904182026;10464.319819211727;10550;11106.555737770399;10409.895901040893;10753.24727269115;10769.192310576582;10882.727931801768;10905;7640.235976402538;7774.494657847222;7788.415868809749;7806.72676456344;7827.921720782947;9994.850077248993;10072.546735396778;10174.542145603318;10188.898111018794;10533.894661053599 21:15:12 INFO - PROCESS | 8819 | |3;mootools.html;1279.1749321687505;1464.9487267945624;1512.7428337182678;1634.5913521619595;1803.828636279553;6671.29951355108;7563.546187228763;7790.805229869256;7801.570913599764;8054.315383192436;7766.611669416535;7917.56453395063;7962.800929976754;7969.123396426388;7982.121966583686;2269.0583407885747;2291.8510296830655;2297.9195728149516;2298.9425264368356;2300.8734519601417;2246.2811900191946;2297.8391512594126;2311.7688231176917;2312.560613483441;2320.164740693349;2272.977270227293;2284.3946354216146;2285.5885940530698;2289.072925465189;2313.560423519534;2215.8559693620023;2238.7649296823843;2243.248511748566;2247.674087257355;2250.088714070796;2210.149092599345;2212.2478357358577;2224.477247846755;2228.309224140505;2230.966535501969;7766.534007959484;7900.407469439758;7987.920120798775;8016.478928869663;8020.839583208303;4583.656225783079;4703.976480117612;4707.529247075299;4721.3390125382475;4725.645576581735;3081.4915538936048;3088.413201491732;3134.5768321276564;3142.151619062863;3161.0674850919036;938.8544775559731;1798.145880706667;1808.9547761305942;1833.1567478959694;1864.3102052240758;10716.732081697943;10807.513661885234;10822.350658960488;10830.620928267474;10837.970392812671;4147.937780933288;4191.517975432865;4309;4321.524632290446;4322.78386080701;8615.13848615146;8648.524331161721;8656.78358041054;8671.34964877624;8686.435381700168;4553.430821147356;4570.405847239837;4588.174128656874;4592.954070459253;4593.6095431888;3804.524434445694;4107.67138628909;4248.383984322318;4250.638695710899;4259.893502662459;3476.5828100628087;3535.275268569937;3568;3586.964130358715;3622.4747411625167;1069.652362982034;1073.8550295710136;1074.8441475985937;1090.9890901090887;1091.7434402915308;698.4377576051328;782.6165179062218;869.9391042627082;891.433939448442;898.5282726568604;5461.5357694596405;5639;5845.09401042839;5857.502112320415;6039.849003774941;851.6295411496019;855.9272461840814;906.0033962641043;925.4308600210957;973.8003709239589;3797.1646237827636;3821.2739579479808;4031.1937612477623;4089.26393249218;4106.568810274938;9839.901600984042;9949.751256218653;10019.499025048719;10022.098011178883;10060.446675432775;9748.366356186825;9891.208703303719;9924.206063514901;9927.15619172364;10025.298229124037;7131.286871312827;7402.370798482081;7575.6969721210535;7583.090029196532;7594.886076708854;5805.10020946754;5839.386864379179;5840.474357307863;5895.970520147372;5959.582829201914;8597.8710319344;9196.35625506208;9284.350095493252;9297;9407.529623518934;8996.955015224881;9200.309976751903;9253.814923701353;9254.213391861498;9258.814823703353;6850.0752398425575;7008.229094799466;7016.719331226694;7023.613701246481;7056.15326160864;7694.307512323918;7881.172476890073;7881.527108373516;7908.367330613422;7910.604469776603;6895.379415852597;7066.328698773608;7070.858582828418;7101.32537408966;7158.856822863618;6957.8956315654295;7045.330693584101;7093.1488221413765;7112.50212485121;7129.607871567114;6237.376262373908;6253.093301471352;6317.368263173646;6324.4940404766585;6328.7152078157515;4708.92936605958;4727.834525791581;4825.420949486084;4868.318435418973;4874.8050077997905;4935.728534930613;4967.205247160437;4980.825671101494;5000.124978128885;5144.485551444825 21:15:12 INFO - PROCESS | 8819 | |4;prototype.html;304.7090029022284;313.8571949762858;321.25949685973836;321.90825614699816;322.57903436016016;4859.465458799529;4867.955458707343;4882.316475693401;4893.632977526682;4900.411950565928;4563.064571762789;4642.143142742896;4700.717956922578;4718.504557021515;4806.255030470274;3712.8700495482663;3718.219173973469;3744.157564547982;3851.114243723945;3874.535055793309;3816.5610954740146;3848.461215429828;3852.7863722927327;3873.128546077124;3878.146807702301;3619.5475565554307;3821.713371497135;3829.8468061277517;3833.0609000794707;3853.344931361661;3742.925141497155;3784.26206889658;3785.848566057354;3793.753406028627;3806.4861243732294;3337.5327454156436;3337.8164200968936;3346.113279980807;3349.844303715214;3351.329734053199;4656.438958572771;4670.579647831712;4712.952870471286;4721.6458765592715;4750.406199225097;4213.536510983789;4357.1721372939355;4430.889227769299;4449.132419178261;4453.79957901892;5071.934893672334;5083.720395378253;5087.79648814047;5089.770960306758;5109.033022286447;3770.754900931458;3787.7159213058853;3791.8104094795426;3795;3812.2756676231706;5113.642045056848;5324.334458192765;5361.865953351158;5375.381831089397;5411.756470958816;3730.806142034577;3735.7945313007504;3747.744505590658;3755.9061023474087;3767.3030489359558;3807.790571518593;3809.9903525565746;3816.8473261069803;3819.6753275971296;3822.2737679840743;4232;4372.759498227628;4386.363977223285;4387.868363949086;4396.648268138541;5046.7476626168545;5071.39143302806;5083.847484575469;5087.389513258433;5088.567471764942;1267.4423253768311;1332.8933685305346;1339.1161833190242;1352.2224720785587;1357.2263809628614;832.0820508727442;858.2447446247387;860.1484530314943;860.2408075485647;934.5140526926097;4458.286674132123;4485.865424037284;4490.57339552742;4497.775111244425;4533.52397998212;5171.456997015259;5173.430922598511;5193.714345711022;5195.272661827347;5203.375594928632;4353.281708518122;4479.708818926824;4482.350059241392;4482.977585112054;4490.932636010462;2735.493933622286;2746.835189888613;2752.848593327346;2767.7370649788236;2771.8198317109322;4851.223804191312;4873.31773551703;4932.975335123301;4937.703737775673;4961;5063.215201643678;5296.867578310573;5389.736310749495;5390.816719228718;5424.701641409761;4985.476524964899;4998.500149984972;5018.723970181675;5022.970291090391;5058.721770302595;5269.780179113254;5306.416294207557;5325.733713314241;5363.302770639792;5380.973095134499;5003.899922001467;5191.636585438983;5197.402298735694;5204.375474943031;5206.869828254324;4979.775910083982;4986.576141028053;5011.84964451067;5048.293238946624;5059.443461219336;3721.609231030811;3728.366177749735;3733.3280009598534;3737.9252414951006;3748.8687895923513;5121.385433747974;5205.219217117311;5223.764930578057;5247.475252474722;5258.684478931276;4990.128701736849;5043.268726034631;5090.440051594248;5111.948880511147;5136.30659860914;4966.18058020437;5074.5940324774665;5124.41069277023;5137.152369858932;5156.071907056766;4840.540148685869;4862.659613826998;5055.180135151416;5060.645754797129;5062.797488100435;5096.592272618256;5117.5394214520875;5130.743462826918;5139.537441630271;5140.640155189101;4987.451380348231;5007.924881126859;5030.698158110525;5031;5036.244563315532 21:15:12 INFO - PROCESS | 8819 | |5;yui.html;690.7720452250757;697.5709938387893;698.4552049401467;706.2584286499175;759.5632511306001;11736.29582225066;11800.58697945571;11839;11864.22882512636;12146.939265303672;11207.719807004829;11244;11252.26860254085;11257.155713321492;11259.718507037307;669.0733334331961;818.7666515043214;845.045099038086;846.1073567386405;848.6605357856876;842.7303262955857;849.1041950741965;849.9150084991483;850.5832142250284;850.8851305073829;905.2803021597846;907.2016625369665;907.4237858959575;908.6410867707252;908.6728777640077;712.7647876200841;876.7501262140323;902.4720538484994;903.3134817538652;907.0249481807084;668.6723505482328;671.7480944645757;672.5527524196403;673.3132205150768;673.3569441183707;11695.415229238504;11772;11794.174407791457;11806.291622502677;11822.940885295518;11310.09519238459;12060.457279422359;12324.938375308157;12366.62900112998;12796;11274.830877536844;11441.199116061878;11915.642530724092;11931;12403.25580465175;4128.380742888561;4191.161767646452;4224.324108142682;4327.545607711208;4377.34339849022;44862.55137448617;48613.270800938015;50150.74924625354;50298;50403.24395134076;9784.266180036526;9922.751931201634;9974.750631234132;10035.197184225244;10048.899511004796;17273.309067637405;17275.827241727675;17291;17294.481165565052;17329.7400538992;6439.967800160969;6476.773312934025;6511.479081673455;6534.019897015486;6798.626075565891;3653.725970552219;3687.041369244016;3706.4996225509212;3764.171882185915;3794.753341032824;2947.1305964740454;2989.1032690192856;3034.9544756828664;3046.84765761711;3049.1157564306545;539.2181337061198;545.4109561673383;547.0836349115216;551.8647931256787;553.7618823905759;521.916493361068;574.5834270154188;576.2048373244979;578.3869098755249;581.6451964301773;6978.205575781736;7229.638518074075;7304.306090921354;7328.377087947584;7446.702131914771;502.2491375393737;543.5732949634597;544.3032917865139;550.6998685716294;562.6624025584616;3550.378683730337;3598.4242521196484;3613.3676606594267;3628.6552777486627;3699.2440631729532;52772.434055692815;55291;55445;56129;56382.43617563854;50161.74919125454;50237.497625024014;50945.74527127341;51448.74275628598;52851.47148528542;42486.78756606197;43378.34932476015;43625.34561981573;47265.76367118143;48073.75963120162;7718.112417071884;7723.5002839521985;7809.921900781147;7909.564973926489;8197.672093116447;30599;31212.375752485277;31903.202419939687;32098.35803283968;32443.18892027718;43366.783166083966;43581.128377432906;43720;44167.77916110399;44462.55537444713;9936.503174841373;9989.700308990741;11145.331280123219;11255.099592032782;11318.547258109584;12103.092268079754;12218.87781122213;12364.319962402154;12514.374281285716;12560.120791544505;10930.209470862828;10966.767971713876;11002.174836887105;11393.316401015965;11778.29330240154;11118.777624447628;11468.713282168013;11512.59705910289;11581.88418115808;11673.941630291794;10880.836787448354;11021.944890275498;11157.553697851996;11327.830082548933;11414.48634811419;9691.660791872533;9774.85337719949;9978.650747224103;10097.19222462216;10407.115395191493;9360.20438262728;9396.95301523488;9495;9504.243769306824;9543.236541076836 21:15:12 INFO - PROCESS | 8819 | __end_tp_report 21:15:12 INFO - PROCESS | 8819 | __start_cc_report 21:15:12 INFO - PROCESS | 8819 | _x_x_mozilla_cycle_collect,918 21:15:12 INFO - PROCESS | 8819 | __end_cc_report 21:15:12 INFO - PROCESS | 8819 | __startTimestamp1463544912658__endTimestamp 21:15:12 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | ------- Summary: start ------- 21:15:12 INFO - PROCESS | 8819 | Number of tests: 6 21:15:12 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | [#0] dojo.html Cycles:165 Average:4751.26 Median:4875.73 stddev:497.72 (10.2%) stddev-sans-first:471.80 21:15:12 INFO - PROCESS | 8819 | Values: 2673.2 2690.9 2715.2 2731.6 2736.7 4690.8 4741.6 4760.5 4814.6 4866.6 4732.4 4753.5 4786.8 4838.3 4838.6 4227.5 4356.8 4454.5 4475.1 4598.5 4480.8 4513.6 4534.9 4539.2 4582.1 4299.2 4349.6 4356.6 4403.5 4403.8 4387.9 4409.1 4457.9 4461.9 4466.7 4428.0 4437.7 4451.1 4478.2 4488.8 4561.5 4655.9 4752.5 4756.9 4782.8 5139.0 5141.9 5175.3 5200.5 5220.9 4986.3 5162.8 5188.7 5203.8 5260.1 4742.5 4868.6 4875.3 4917.6 4941.7 5377.1 5405.2 5405.3 5414.9 5428.2 4891.2 5087.9 5145.4 5149.2 5159.7 5061.0 5104.1 5111.9 5194.8 5201.4 5089.7 5089.8 5096.7 5098.2 5139.4 5069.0 5077.6 5078.2 5085.5 5085.9 4260.8 4296.3 4297.0 4302.8 4348.5 3770.8 3804.0 3805.2 3812.1 3816.8 4427.9 4429.3 4430.9 4461.1 4473.8 5129.3 5142.6 5144.1 5144.5 5146.0 4295.7 4353.1 4410.5 4431.5 4466.9 4694.4 4705.6 4708.2 4734.4 4744.7 4890.4 4930.4 4933.6 4946.5 4985.7 5044.9 5076.3 5089.1 5142.8 5199.1 4853.8 4875.7 4881.0 4891.4 4896.2 5008.8 5015.6 5015.7 5018.7 5060.8 5020.9 5136.4 5160.5 5167.8 5202.0 5010.4 5044.2 5047.3 5052.5 5083.9 4820.9 4947.9 4988.6 4992.6 5006.2 4815.4 4833.2 4849.2 4904.7 4929.9 4979.7 4989.8 4992.5 5000.4 5021.3 4791.3 4804.7 4859.5 4860.1 4902.2 21:15:12 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | [#1] ext.html Cycles:180 Average:50595.79 Median:36765.77 stddev:91792.22 (249.7%) stddev-sans-first:91972.86 21:15:12 INFO - PROCESS | 8819 | Values: 565.4 601.5 607.6 608.7 612.5 28488.1 42899.0 43894.8 43958.3 43962.8 43631.3 44359.8 44455.8 44505.0 44541.6 7481.9 7635.1 7637.7 7996.4 8173.4 7552.3 10095.2 10319.7 10335.1 10605.6 10321.4 10399.6 10420.9 10436.5 10444.7 7560.2 7748.3 10226.7 10297.1 10303.7 7630.2 9479.4 9647.4 9668.3 9689.4 40471.4 40594.8 40903.4 41045.4 41074.2 2966.2 3115.3 3149.6 3152.5 3315.0 29820.1 29957.0 30057.4 30608.2 30619.1 3378.3 3464.8 3521.1 3548.8 3619.0 276633.0 278248.0 278736.0 279675.0 281670.0 59078.8 59451.0 59512.0 59561.0 59668.7 61321.6 61519.0 61641.0 61672.7 61794.7 13716.2 14093.7 14104.6 14110.2 14118.9 10409.2 10464.5 10506.7 10640.8 10768.8 18644.5 18774.2 18809.8 19457.2 19487.1 6997.4 7084.1 7145.9 7205.8 7232.4 842.4 885.9 927.4 961.3 992.2 29011.0 29517.6 29577.7 29579.3 30050.4 947.3 947.4 969.7 988.4 1075.7 15146.8 15475.4 15626.8 15831.7 15897.8 435246.0 438605.0 439284.0 439729.0 440019.0 51494.0 51751.0 52066.7 52256.5 52409.5 1142.6 1153.2 1189.0 1239.7 1260.2 27452.6 29855.1 30319.8 30673.5 30712.4 43597.8 44159.3 44164.6 44197.8 44306.3 302991.0 306151.0 306272.2 306680.0 306906.0 21408.6 23644.9 25784.5 25850.9 27018.2 42709.8 43064.6 43375.0 44342.0 44364.3 37367.3 37504.8 37561.8 37905.4 38155.2 36071.3 36393.1 37138.4 37445.8 41034.0 37643.8 37840.8 38756.6 38863.0 38892.0 33159.3 34570.8 34868.7 34938.3 35223.8 25169.9 26014.9 26089.7 26134.5 26263.9 21:15:12 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | [#2] jquery.html Cycles:180 Average:24747.42 Median:4490.12 stddev:65081.21 (1449.4%) stddev-sans-first:65238.08 21:15:12 INFO - PROCESS | 8819 | Values: 387.4 389.3 390.3 393.3 404.8 12975.2 13210.5 16278.8 17722.6 17789.1 16314.6 16413.5 16653.3 17383.1 17421.1 5153.6 5282.8 5287.2 5310.1 5352.7 5132.1 5173.0 5240.2 5247.3 5264.3 5160.1 5170.6 5183.7 5188.5 5210.8 5073.2 5100.4 5180.8 5201.1 5205.8 4617.6 4626.4 4633.7 4647.0 4690.2 19651.7 20675.5 20848.5 20929.4 20950.4 1959.7 1969.8 1982.2 2026.5 2542.2 8735.3 9154.0 9383.4 12550.7 13659.2 1717.6 1773.3 1809.9 1820.0 1823.8 67906.3 68733.0 69216.0 69283.7 71214.0 10125.2 10178.8 10197.6 10313.9 10404.1 14341.2 14412.6 14433.5 14466.6 14473.6 6894.7 6908.0 7042.2 7045.2 7084.1 6266.8 6295.4 6309.3 6400.8 6401.5 4451.8 4528.5 4541.1 4546.6 4563.5 1839.5 1851.3 1856.9 1858.1 1901.1 797.6 906.0 980.3 987.0 989.2 16243.2 16986.4 16994.2 17270.2 17725.4 858.1 863.2 888.5 894.1 967.6 8688.0 9509.2 9631.3 9803.3 9839.7 373477.0 388864.0 397753.0 398927.0 401559.0 82833.6 90702.0 91108.5 91732.5 92030.5 962.9 969.7 976.5 996.4 1010.3 15721.6 15735.2 15857.4 16031.6 16170.5 32729.0 33854.0 39459.2 39937.0 40190.2 46820.5 48426.3 48791.8 54977.0 55777.9 7340.3 7854.0 7959.0 7989.9 8018.7 8693.3 11419.5 11520.1 11651.8 11759.2 9869.8 10459.3 10517.5 10598.3 10598.9 10273.3 10454.8 10464.3 10550.0 11106.6 10409.9 10753.2 10769.2 10882.7 10905.0 7640.2 7774.5 7788.4 7806.7 7827.9 9994.9 10072.5 10174.5 10188.9 10533.9 21:15:12 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | [#3] mootools.html Cycles:180 Average:5303.80 Median:4990.48 stddev:2894.55 (58.0%) stddev-sans-first:2886.87 21:15:12 INFO - PROCESS | 8819 | Values: 1279.2 1464.9 1512.7 1634.6 1803.8 6671.3 7563.5 7790.8 7801.6 8054.3 7766.6 7917.6 7962.8 7969.1 7982.1 2269.1 2291.9 2297.9 2298.9 2300.9 2246.3 2297.8 2311.8 2312.6 2320.2 2273.0 2284.4 2285.6 2289.1 2313.6 2215.9 2238.8 2243.2 2247.7 2250.1 2210.1 2212.2 2224.5 2228.3 2231.0 7766.5 7900.4 7987.9 8016.5 8020.8 4583.7 4704.0 4707.5 4721.3 4725.6 3081.5 3088.4 3134.6 3142.2 3161.1 938.9 1798.1 1809.0 1833.2 1864.3 10716.7 10807.5 10822.4 10830.6 10838.0 4147.9 4191.5 4309.0 4321.5 4322.8 8615.1 8648.5 8656.8 8671.3 8686.4 4553.4 4570.4 4588.2 4593.0 4593.6 3804.5 4107.7 4248.4 4250.6 4259.9 3476.6 3535.3 3568.0 3587.0 3622.5 1069.7 1073.9 1074.8 1091.0 1091.7 698.4 782.6 869.9 891.4 898.5 5461.5 5639.0 5845.1 5857.5 6039.8 851.6 855.9 906.0 925.4 973.8 3797.2 3821.3 4031.2 4089.3 4106.6 9839.9 9949.8 10019.5 10022.1 10060.4 9748.4 9891.2 9924.2 9927.2 10025.3 7131.3 7402.4 7575.7 7583.1 7594.9 5805.1 5839.4 5840.5 5896.0 5959.6 8597.9 9196.4 9284.4 9297.0 9407.5 8997.0 9200.3 9253.8 9254.2 9258.8 6850.1 7008.2 7016.7 7023.6 7056.2 7694.3 7881.2 7881.5 7908.4 7910.6 6895.4 7066.3 7070.9 7101.3 7158.9 6957.9 7045.3 7093.1 7112.5 7129.6 6237.4 6253.1 6317.4 6324.5 6328.7 4708.9 4727.8 4825.4 4868.3 4874.8 4935.7 4967.2 4980.8 5000.1 5144.5 21:15:12 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | [#4] prototype.html Cycles:180 Average:4243.97 Median:4845.88 stddev:1223.23 (25.2%) stddev-sans-first:1190.39 21:15:12 INFO - PROCESS | 8819 | Values: 304.7 313.9 321.3 321.9 322.6 4859.5 4868.0 4882.3 4893.6 4900.4 4563.1 4642.1 4700.7 4718.5 4806.3 3712.9 3718.2 3744.2 3851.1 3874.5 3816.6 3848.5 3852.8 3873.1 3878.1 3619.5 3821.7 3829.8 3833.1 3853.3 3742.9 3784.3 3785.8 3793.8 3806.5 3337.5 3337.8 3346.1 3349.8 3351.3 4656.4 4670.6 4713.0 4721.6 4750.4 4213.5 4357.2 4430.9 4449.1 4453.8 5071.9 5083.7 5087.8 5089.8 5109.0 3770.8 3787.7 3791.8 3795.0 3812.3 5113.6 5324.3 5361.9 5375.4 5411.8 3730.8 3735.8 3747.7 3755.9 3767.3 3807.8 3810.0 3816.8 3819.7 3822.3 4232.0 4372.8 4386.4 4387.9 4396.6 5046.7 5071.4 5083.8 5087.4 5088.6 1267.4 1332.9 1339.1 1352.2 1357.2 832.1 858.2 860.1 860.2 934.5 4458.3 4485.9 4490.6 4497.8 4533.5 5171.5 5173.4 5193.7 5195.3 5203.4 4353.3 4479.7 4482.4 4483.0 4490.9 2735.5 2746.8 2752.8 2767.7 2771.8 4851.2 4873.3 4933.0 4937.7 4961.0 5063.2 5296.9 5389.7 5390.8 5424.7 4985.5 4998.5 5018.7 5023.0 5058.7 5269.8 5306.4 5325.7 5363.3 5381.0 5003.9 5191.6 5197.4 5204.4 5206.9 4979.8 4986.6 5011.8 5048.3 5059.4 3721.6 3728.4 3733.3 3737.9 3748.9 5121.4 5205.2 5223.8 5247.5 5258.7 4990.1 5043.3 5090.4 5111.9 5136.3 4966.2 5074.6 5124.4 5137.2 5156.1 4840.5 4862.7 5055.2 5060.6 5062.8 5096.6 5117.5 5130.7 5139.5 5140.6 4987.5 5007.9 5030.7 5031.0 5036.2 21:15:12 INFO - PROCESS | 8819 | 21:15:12 INFO - PROCESS | 8819 | [#5] yui.html Cycles:180 Average:13358.50 Median:46064.16 stddev:15619.02 (33.9%) stddev-sans-first:15633.87 21:15:12 INFO - PROCESS | 8819 | Values: 690.8 697.6 698.5 706.3 759.6 11736.3 11800.6 11839.0 11864.2 12146.9 11207.7 11244.0 11252.3 11257.2 11259.7 669.1 818.8 845.0 846.1 848.7 842.7 849.1 849.9 850.6 850.9 905.3 907.2 907.4 908.6 908.7 712.8 876.8 902.5 903.3 907.0 668.7 671.7 672.6 673.3 673.4 11695.4 11772.0 11794.2 11806.3 11822.9 11310.1 12060.5 12324.9 12366.6 12796.0 11274.8 11441.2 11915.6 11931.0 12403.3 4128.4 4191.2 4224.3 4327.5 4377.3 44862.6 48613.3 50150.7 50298.0 50403.2 9784.3 9922.8 9974.8 10035.2 10048.9 17273.3 17275.8 17291.0 17294.5 17329.7 6440.0 6476.8 6511.5 6534.0 6798.6 3653.7 3687.0 3706.5 3764.2 3794.8 2947.1 2989.1 3035.0 3046.8 3049.1 539.2 545.4 547.1 551.9 553.8 521.9 574.6 576.2 578.4 581.6 6978.2 7229.6 7304.3 7328.4 7446.7 502.2 543.6 544.3 550.7 562.7 3550.4 3598.4 3613.4 3628.7 3699.2 52772.4 55291.0 55445.0 56129.0 56382.4 50161.7 50237.5 50945.7 51448.7 52851.5 42486.8 43378.3 43625.3 47265.8 48073.8 7718.1 7723.5 7809.9 7909.6 8197.7 30599.0 31212.4 31903.2 32098.4 32443.2 43366.8 43581.1 43720.0 44167.8 44462.6 9936.5 9989.7 11145.3 11255.1 11318.5 12103.1 12218.9 12364.3 12514.4 12560.1 10930.2 10966.8 11002.2 11393.3 11778.3 11118.8 11468.7 11512.6 11581.9 11673.9 10880.8 11021.9 11157.6 11327.8 11414.5 9691.7 9774.9 9978.7 10097.2 10407.1 9360.2 9397.0 9495.0 9504.2 9543.2 21:15:12 INFO - PROCESS | 8819 | -------- Summary: end -------- 21:15:12 INFO - PROCESS | 8819 | 21:15:13 INFO - TEST-INFO | 8819: exit 0 21:15:13 INFO - TEST-OK | dromaeo_css | took 1119213ms 21:15:13 INFO - TEST-START | kraken 21:15:13 INFO - operating with platform_type : linux_ 21:15:13 INFO - Initialising browser for kraken test... 21:15:13 INFO - TEST-INFO | started process 9000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfEZOAN/profile http://localhost:57899/getInfo.html) 21:15:17 INFO - PROCESS | 9000 | __metrics Screen width/height:1600/1200 21:15:17 INFO - PROCESS | 9000 | colorDepth:24 21:15:17 INFO - PROCESS | 9000 | Browser inner width/height: 1024/697 21:15:17 INFO - PROCESS | 9000 | __metrics 21:15:18 ERROR - PROCESS | 9000 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:15:19 INFO - TEST-INFO | 9000: exit 0 21:15:19 INFO - Browser initialized. 21:15:19 INFO - Running cycle 1/1 for kraken test... 21:15:19 INFO - TEST-INFO | started process 9079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfEZOAN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:15:30 INFO - PROCESS | 9079 | RSS: Main: 154767360 21:15:30 INFO - PROCESS | 9079 | 21:15:33 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57899/tests/kraken/driver.html?testName=audio-beat-detection) 21:15:34 INFO - PROCESS | 9079 | RSS: Main: 210280448 21:15:34 INFO - PROCESS | 9079 | 21:15:37 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57899/tests/kraken/driver.html?testName=audio-dft) 21:15:38 INFO - PROCESS | 9079 | RSS: Main: 198197248 21:15:38 INFO - PROCESS | 9079 | 21:15:41 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57899/tests/kraken/driver.html?testName=audio-fft) 21:15:42 INFO - PROCESS | 9079 | RSS: Main: 266731520 21:15:42 INFO - PROCESS | 9079 | 21:15:44 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57899/tests/kraken/driver.html?testName=audio-oscillator) 21:15:44 INFO - PROCESS | 9079 | RSS: Main: 175210496 21:15:44 INFO - PROCESS | 9079 | 21:15:47 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57899/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:15:47 INFO - PROCESS | 9079 | RSS: Main: 180514816 21:15:47 INFO - PROCESS | 9079 | 21:15:51 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57899/tests/kraken/driver.html?testName=imaging-darkroom) 21:15:51 INFO - PROCESS | 9079 | RSS: Main: 216498176 21:15:51 INFO - PROCESS | 9079 | 21:15:55 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57899/tests/kraken/driver.html?testName=imaging-desaturate) 21:15:56 INFO - PROCESS | 9079 | RSS: Main: 214708224 21:15:56 INFO - PROCESS | 9079 | 21:15:59 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57899/tests/kraken/driver.html?testName=json-parse-financial) 21:15:59 INFO - PROCESS | 9079 | RSS: Main: 214859776 21:15:59 INFO - PROCESS | 9079 | 21:16:01 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57899/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:16:02 INFO - PROCESS | 9079 | RSS: Main: 208629760 21:16:02 INFO - PROCESS | 9079 | 21:16:04 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57899/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:16:04 INFO - PROCESS | 9079 | RSS: Main: 211484672 21:16:04 INFO - PROCESS | 9079 | 21:16:07 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57899/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:16:07 INFO - PROCESS | 9079 | RSS: Main: 217055232 21:16:07 INFO - PROCESS | 9079 | 21:16:10 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:16:11 INFO - PROCESS | 9079 | RSS: Main: 218644480 21:16:11 INFO - PROCESS | 9079 | 21:16:14 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:16:14 INFO - PROCESS | 9079 | RSS: Main: 218771456 21:16:14 INFO - PROCESS | 9079 | 21:16:16 INFO - PROCESS | 9079 | Cycle 1(1): loaded http://localhost:57899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57899/tests/kraken/driver.html?testName=ai-astar) 21:16:16 INFO - PROCESS | 9079 | RSS: Main: 265760768 21:16:16 INFO - PROCESS | 9079 | 21:16:16 INFO - PROCESS | 9079 | __start_tp_report 21:16:16 INFO - PROCESS | 9079 | _x_x_mozilla_page_load 21:16:16 INFO - PROCESS | 9079 | _x_x_mozilla_page_load_details 21:16:16 INFO - PROCESS | 9079 | |i|pagename|runs| 21:16:16 INFO - PROCESS | 9079 | |0;ai-astar;115;109;113;112;114;113;112;113;112;112 21:16:16 INFO - PROCESS | 9079 | |1;audio-beat-detection;161;136;159;214;131;155;154;135;184;133 21:16:16 INFO - PROCESS | 9079 | |2;audio-dft;164;162;161;165;163;163;168;164;164;162 21:16:16 INFO - PROCESS | 9079 | |3;audio-fft;79;80;76;158;76;76;75;76;130;77 21:16:16 INFO - PROCESS | 9079 | |4;audio-oscillator;93;94;151;92;93;93;125;93;93;116 21:16:16 INFO - PROCESS | 9079 | |5;imaging-gaussian-blur;119;117;117;118;117;117;118;118;118;119 21:16:16 INFO - PROCESS | 9079 | |6;imaging-darkroom;147;146;146;146;147;146;146;146;146;147 21:16:16 INFO - PROCESS | 9079 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 21:16:16 INFO - PROCESS | 9079 | |8;json-parse-financial;66;65;65;66;66;64;66;66;63;65 21:16:16 INFO - PROCESS | 9079 | |9;json-stringify-tinderbox;64;66;64;65;66;64;64;66;66;67 21:16:16 INFO - PROCESS | 9079 | |10;stanford-crypto-aes;83;82;82;81;82;82;84;84;164;83 21:16:17 INFO - PROCESS | 9079 | |11;stanford-crypto-ccm;139;130;137;128;127;140;139;135;159;132 21:16:17 INFO - PROCESS | 9079 | |12;stanford-crypto-pbkdf2;169;166;167;164;164;172;167;168;166;165 21:16:17 INFO - PROCESS | 9079 | |13;stanford-crypto-sha256-iterative;67;68;67;65;65;66;66;66;64;65 21:16:17 INFO - PROCESS | 9079 | __end_tp_report 21:16:17 INFO - PROCESS | 9079 | __start_cc_report 21:16:17 INFO - PROCESS | 9079 | _x_x_mozilla_cycle_collect,2122 21:16:17 INFO - PROCESS | 9079 | __end_cc_report 21:16:17 INFO - PROCESS | 9079 | __startTimestamp1463544976992__endTimestamp 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | ------- Summary: start ------- 21:16:17 INFO - PROCESS | 9079 | Number of tests: 14 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.58 (1.4%) stddev-sans-first:1.39 21:16:17 INFO - PROCESS | 9079 | Values: 115.0 109.0 113.0 112.0 114.0 113.0 112.0 113.0 112.0 112.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:157.00 stddev:26.21 (16.7%) stddev-sans-first:27.74 21:16:17 INFO - PROCESS | 9079 | Values: 161.0 136.0 159.0 214.0 131.0 155.0 154.0 135.0 184.0 133.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.96 (1.2%) stddev-sans-first:2.07 21:16:17 INFO - PROCESS | 9079 | Values: 164.0 162.0 161.0 165.0 163.0 163.0 168.0 164.0 164.0 162.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#3] audio-fft Cycles:10 Average:90.30 Median:76.00 stddev:29.10 (38.3%) stddev-sans-first:30.58 21:16:17 INFO - PROCESS | 9079 | Values: 79.0 80.0 76.0 158.0 76.0 76.0 75.0 76.0 130.0 77.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:93.00 stddev:20.12 (21.6%) stddev-sans-first:20.92 21:16:17 INFO - PROCESS | 9079 | Values: 93.0 94.0 151.0 92.0 93.0 93.0 125.0 93.0 93.0 116.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 21:16:17 INFO - PROCESS | 9079 | Values: 119.0 117.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 119.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 21:16:17 INFO - PROCESS | 9079 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:16:17 INFO - PROCESS | 9079 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 21:16:17 INFO - PROCESS | 9079 | Values: 66.0 65.0 65.0 66.0 66.0 64.0 66.0 66.0 63.0 65.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 21:16:17 INFO - PROCESS | 9079 | Values: 64.0 66.0 64.0 65.0 66.0 64.0 64.0 66.0 66.0 67.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:82.50 stddev:25.77 (31.2%) stddev-sans-first:27.19 21:16:17 INFO - PROCESS | 9079 | Values: 83.0 82.0 82.0 81.0 82.0 82.0 84.0 84.0 164.0 83.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:138.00 stddev:9.18 (6.7%) stddev-sans-first:9.70 21:16:17 INFO - PROCESS | 9079 | Values: 139.0 130.0 137.0 128.0 127.0 140.0 139.0 135.0 159.0 132.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:2.44 (1.5%) stddev-sans-first:2.46 21:16:17 INFO - PROCESS | 9079 | Values: 169.0 166.0 167.0 164.0 164.0 172.0 167.0 168.0 166.0 165.0 21:16:17 INFO - PROCESS | 9079 | 21:16:17 INFO - PROCESS | 9079 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 21:16:17 INFO - PROCESS | 9079 | Values: 67.0 68.0 67.0 65.0 65.0 66.0 66.0 66.0 64.0 65.0 21:16:17 INFO - PROCESS | 9079 | -------- Summary: end -------- 21:16:17 INFO - PROCESS | 9079 | 21:16:18 INFO - TEST-INFO | 9079: exit 0 21:16:18 INFO - TEST-OK | kraken | took 64618ms 21:16:18 INFO - SUITE-END | took 1183s 21:16:18 INFO - Completed test suite (00:19:43) 21:16:18 INFO - javascript benchmark 21:16:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.2381271337667, 2690.852003139829, 2715.158300926713, 2731.63122978398, 2736.7263273672634, 4690.788914498848, 4741.64437667175, 4760.452547956986, 4814.614830813535, 4866.635002374823, 4732.408448943882, 4753.524647535245, 4786.83246086387, 4838.34682317887, 4838.588719958808, 4227.534971153171, 4356.7821608919585, 4454.487733910593, 4475.082608065355, 4598.494165641777, 4480.820767169325, 4513.571210734975, 4534.8639540813665, 4539.160255352754, 4582.060677561109, 4299.226139294926, 4349.630281426051, 4356.586124318184, 4403.537628548988, 4403.779811009436, 4387.934180987256, 4409.0520538084465, 4457.866264012085, 4461.888452788674, 4466.665000125004, 4427.977860110679, 4437.733735975819, 4451.065276291983, 4478.193925093482, 4488.798004089824, 4561.452625684906, 4655.86032419028, 4752.5247475252545, 4756.881077973044, 4782.784774685113, 5138.974305128488, 5141.871453213699, 5175.327207463043, 5200.453952334989, 5220.947790522084, 4986.301917731521, 5162.767675454614, 5188.688678679254, 5203.765830537597, 5260.053190425722, 4742.50203728607, 4868.610511159099, 4875.317455556225, 4917.606591472673, 4941.728204948762, 5377.112776391929, 5405.162199859028, 5405.297311349499, 5414.918776218281, 5428.185772134132, 4891.2174052152195, 5087.8982420351385, 5145.408278048072, 5149.227615857576, 5159.690418574897, 5060.962502686941, 5104.132297509433, 5111.923321150111, 5194.818181363634, 5201.375834899836, 5089.720065396439, 5089.847304580869, 5096.745162741922, 5098.1842905135, 5139.408967968731, 5069.0, 5077.644564880423, 5078.187490001582, 5085.516875896784, 5085.898282034339, 4260.829566817354, 4296.2911119664905, 4296.978515107405, 4302.827886884552, 4348.5216626171095, 3770.849166033383, 3804.0489877530617, 3805.1818858945458, 3812.1041555234497, 3816.7900765458166, 4427.911441771146, 4429.313456414261, 4430.933535996963, 4461.08547747711, 4473.821047158142, 5129.281900533928, 5142.61430392722, 5144.074066668036, 5144.485551444825, 5145.974270128625, 4295.72077814941, 4353.064091220403, 4410.492793328808, 4431.4903786065015, 4466.9106617867465, 4694.43666759991, 4705.623550115983, 4708.152532544175, 4734.431868175841, 4744.715317080986, 4890.364252647133, 4930.383702037246, 4933.58064564516, 4946.480619534897, 4985.675931064469, 5044.9243261350375, 5076.289319495199, 5089.05852417304, 5142.845714628567, 5199.142141546602, 4853.757312134449, 4875.731834749123, 4881.023795240895, 4891.388576427947, 4896.216605343128, 5008.824691135793, 5015.648904576645, 5015.7492125392855, 5018.723970181529, 5060.797568097382, 5020.949790502194, 5136.383633963948, 5160.509751573594, 5167.844964651066, 5202.0116177926075, 5010.398752149766, 5044.243363495359, 5047.268146118866, 5052.520010598987, 5083.898322033612, 4820.927686084641, 4947.851564453073, 4988.625853060962, 4992.550670439678, 5006.199008158823, 4815.446223684181, 4833.154198015403, 4849.151398505318, 4904.705717656952, 4929.926051109164, 4979.701217926936, 4989.750512474289, 4992.450830408579, 5000.424951130666, 5021.271915572294, 4791.257355109963, 4804.663673542818, 4859.538343857328, 4860.1008813369635, 4902.166631672696], "value": 4719.771637518769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.3809079058432, 601.4767152577258, 607.6293460988793, 608.6561092982467, 612.4518555892477, 28488.14535563934, 42899.0, 43894.780526097325, 43958.340624890574, 43962.7801860991, 43631.34552981708, 44359.77820110903, 44455.77772111143, 44505.0, 44541.55458445415, 7481.925180748177, 7635.121960974476, 7637.694492220305, 7996.360291176721, 8173.386995975296, 7552.3202911737935, 10095.242856785733, 10319.742006449862, 10335.069843714064, 10605.628802991896, 10321.380717156957, 10399.584016639325, 10420.895791042069, 10436.478176091203, 10444.738881527946, 7560.168381478033, 7748.263914928073, 10226.744331391701, 10297.073263406292, 10303.690889273334, 7630.198829122917, 9479.383840050443, 9647.421154730739, 9668.274879384075, 9689.418634881858, 40471.392929105794, 40594.79702601468, 40903.38644920329, 41045.384319235236, 41074.178516429805, 2966.2287805170595, 3115.3302040061494, 3149.622045354572, 3152.4640811061945, 3314.950275745866, 29820.10539683813, 29957.0, 30057.398852022838, 30608.2347941301, 30619.08142755721, 3378.2736711606876, 3464.826758662057, 3521.1197200699826, 3548.8048157351336, 3618.9866837285604, 276633.0, 278248.0, 278736.0, 279675.0, 281670.0, 59078.79672634397, 59451.0, 59512.0, 59561.0, 59668.70165649144, 61321.641403031026, 61519.0, 61641.0, 61672.691636542426, 61794.69102654548, 13716.245606491739, 14093.71812563743, 14104.647383815487, 14110.22393768332, 14118.85881141196, 10409.167266618804, 10464.52909619069, 10506.684799456028, 10640.84038739404, 10768.838467422995, 18644.533886652673, 18774.249030038645, 18809.811901880807, 19457.22171113168, 19487.123079461457, 6997.440204783605, 7084.149902011792, 7145.8928116078305, 7205.819854503679, 7232.421406287484, 842.3682238321259, 885.9246964008003, 927.3971918253054, 961.274237950357, 992.156666833186, 29011.0, 29517.557236641467, 29577.704222957494, 29579.26051848721, 30050.398992020037, 947.2706016367358, 947.3510645208055, 969.7236287658125, 988.4069558265127, 1075.6988043347876, 15146.848531514765, 15475.400089184055, 15626.843731562767, 15831.683366332609, 15897.841021589637, 435246.0, 438605.0, 439284.0, 439729.0, 440019.0, 51494.0, 51751.0, 52066.73966630142, 52256.47743522516, 52409.47590524122, 1142.6229344316355, 1153.1754795321385, 1188.9762204755684, 1239.69007748063, 1260.2249616485794, 27452.588211177248, 29855.10434686963, 30319.848400757855, 30673.53989690112, 30712.385752285278, 43597.782011089745, 44159.33760993652, 44164.55835441733, 44197.779011104736, 44306.335404968304, 302991.0, 306151.0, 306272.1550314665, 306680.0, 306906.0, 21408.57182856303, 23644.881775591013, 25784.484310314063, 25850.870745646906, 27018.1894543164, 42709.78645106879, 43064.569354306055, 43375.0, 44342.0, 44364.33453498135, 37367.252654946205, 37504.81247593745, 37561.81219093887, 37905.4314185293, 38155.2368952625, 36071.27857442889, 36393.09017274589, 37138.44292335671, 37445.81277093597, 41034.0, 37643.81178094092, 37840.81079594584, 38756.6124338753, 38863.0, 38892.0, 33159.33681326408, 34570.82714586411, 34868.65131348654, 34938.30123397569, 35223.82388088043, 25169.87415062913, 26014.86992565025, 26089.73910260873, 26134.477310454065, 26263.868680656473], "value": 18587.810895465547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.3666555182277, 389.31869228849513, 390.33745302390435, 393.3313367275632, 404.8239016028028, 12975.15661482003, 13210.471581136768, 16278.837211627895, 17722.556936076606, 17789.110544472773, 16314.592135196626, 16413.507594772145, 16653.25060372283, 17383.13084345784, 17421.128943552805, 5153.587712982952, 5282.815101471449, 5287.154055351145, 5310.07073762092, 5352.678839269637, 5132.101882170624, 5172.974135129338, 5240.213967904807, 5247.265382846385, 5264.315638966929, 5160.122779127557, 5170.560502357304, 5183.740812959356, 5188.455212202721, 5210.7655155517905, 5073.213651883927, 5100.438951715309, 5180.818671346504, 5201.115810312237, 5205.843824685266, 4617.630589552828, 4626.375439315683, 4633.745144017078, 4647.047355292191, 4690.202665546865, 19651.705224421647, 20675.483112922146, 20848.47878803027, 20929.372118836458, 20950.37148885536, 1959.6570600144917, 1969.812867777559, 1982.2071171531359, 2026.4629873083645, 2542.1992072497287, 8735.34484913634, 9153.99306076331, 9383.390079644802, 12550.68623284416, 13659.248741319223, 1717.6478821841492, 1773.2906837265068, 1809.9366522171792, 1819.9818001819945, 1823.772028496438, 67906.3209367905, 68732.96900546546, 69216.0, 69283.65358173176, 71214.0, 10125.240606954509, 10178.847317290247, 10197.592096316213, 10313.948430257951, 10404.063634272952, 14341.211233382055, 14412.567622971328, 14433.494827680981, 14466.638334041732, 14473.638159045897, 6894.689738961759, 6908.0, 7042.190148132928, 7045.189803172599, 7084.079069720903, 6266.843328916813, 6295.37046295376, 6309.274433440121, 6400.807975760735, 6401.487880969511, 4451.77741112943, 4528.467795119812, 4541.069080838421, 4546.590806827401, 4563.520830312836, 1839.45736007878, 1851.2502436513234, 1856.860735444847, 1858.0895361272878, 1901.1349835824667, 797.5533701127388, 905.9954700226589, 980.2794945714894, 986.9883369546272, 989.2432289298692, 16243.187840607923, 16986.405475808286, 16994.150292485327, 17270.22283997223, 17725.379611713528, 858.0689951402674, 863.1799790199336, 888.4624801994829, 894.065701342099, 967.6468089147411, 8687.956560217159, 9509.191718703849, 9631.266372052958, 9803.313768036169, 9839.655612053544, 373477.0, 388864.0, 397753.0, 398927.0, 401559.0, 82833.58583207046, 90702.0, 91108.54445727862, 91732.54133729289, 92030.53984730167, 962.8892677342195, 969.709087273815, 976.5019839881711, 996.4170959988488, 1010.2675560218782, 15721.606959826096, 15735.213239338216, 15857.365705371656, 16031.599210019844, 16170.514884553482, 32729.0, 33854.0, 39459.2108157841, 39937.0, 40190.1961960765, 46820.531794681614, 48426.27360589665, 48791.75604121957, 54977.0, 55777.88444231012, 7340.339369456775, 7854.0, 7959.0, 7989.880151797612, 8018.719344823136, 8693.30453563726, 11419.486123124645, 11520.078393728649, 11651.76696466049, 11759.235649682743, 9869.753256168653, 10459.320144190604, 10517.474126293502, 10598.25812193139, 10598.947005264925, 10273.280870339304, 10454.790904182026, 10464.319819211727, 10550.0, 11106.555737770399, 10409.895901040893, 10753.24727269115, 10769.192310576582, 10882.727931801768, 10905.0, 7640.235976402538, 7774.494657847222, 7788.415868809749, 7806.72676456344, 7827.921720782947, 9994.850077248993, 10072.546735396778, 10174.542145603318, 10188.898111018794, 10533.894661053599], "value": 8308.982819623474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.1749321687505, 1464.9487267945624, 1512.7428337182678, 1634.5913521619595, 1803.828636279553, 6671.29951355108, 7563.546187228763, 7790.805229869256, 7801.570913599764, 8054.315383192436, 7766.611669416535, 7917.56453395063, 7962.800929976754, 7969.123396426388, 7982.121966583686, 2269.0583407885747, 2291.8510296830655, 2297.9195728149516, 2298.9425264368356, 2300.8734519601417, 2246.2811900191946, 2297.8391512594126, 2311.7688231176917, 2312.560613483441, 2320.164740693349, 2272.977270227293, 2284.3946354216146, 2285.5885940530698, 2289.072925465189, 2313.560423519534, 2215.8559693620023, 2238.7649296823843, 2243.248511748566, 2247.674087257355, 2250.088714070796, 2210.149092599345, 2212.2478357358577, 2224.477247846755, 2228.309224140505, 2230.966535501969, 7766.534007959484, 7900.407469439758, 7987.920120798775, 8016.478928869663, 8020.839583208303, 4583.656225783079, 4703.976480117612, 4707.529247075299, 4721.3390125382475, 4725.645576581735, 3081.4915538936048, 3088.413201491732, 3134.5768321276564, 3142.151619062863, 3161.0674850919036, 938.8544775559731, 1798.145880706667, 1808.9547761305942, 1833.1567478959694, 1864.3102052240758, 10716.732081697943, 10807.513661885234, 10822.350658960488, 10830.620928267474, 10837.970392812671, 4147.937780933288, 4191.517975432865, 4309.0, 4321.524632290446, 4322.78386080701, 8615.13848615146, 8648.524331161721, 8656.78358041054, 8671.34964877624, 8686.435381700168, 4553.430821147356, 4570.405847239837, 4588.174128656874, 4592.954070459253, 4593.6095431888, 3804.524434445694, 4107.67138628909, 4248.383984322318, 4250.638695710899, 4259.893502662459, 3476.5828100628087, 3535.275268569937, 3568.0, 3586.964130358715, 3622.4747411625167, 1069.652362982034, 1073.8550295710136, 1074.8441475985937, 1090.9890901090887, 1091.7434402915308, 698.4377576051328, 782.6165179062218, 869.9391042627082, 891.433939448442, 898.5282726568604, 5461.5357694596405, 5639.0, 5845.09401042839, 5857.502112320415, 6039.849003774941, 851.6295411496019, 855.9272461840814, 906.0033962641043, 925.4308600210957, 973.8003709239589, 3797.1646237827636, 3821.2739579479808, 4031.1937612477623, 4089.26393249218, 4106.568810274938, 9839.901600984042, 9949.751256218653, 10019.499025048719, 10022.098011178883, 10060.446675432775, 9748.366356186825, 9891.208703303719, 9924.206063514901, 9927.15619172364, 10025.298229124037, 7131.286871312827, 7402.370798482081, 7575.6969721210535, 7583.090029196532, 7594.886076708854, 5805.10020946754, 5839.386864379179, 5840.474357307863, 5895.970520147372, 5959.582829201914, 8597.8710319344, 9196.35625506208, 9284.350095493252, 9297.0, 9407.529623518934, 8996.955015224881, 9200.309976751903, 9253.814923701353, 9254.213391861498, 9258.814823703353, 6850.0752398425575, 7008.229094799466, 7016.719331226694, 7023.613701246481, 7056.15326160864, 7694.307512323918, 7881.172476890073, 7881.527108373516, 7908.367330613422, 7910.604469776603, 6895.379415852597, 7066.328698773608, 7070.858582828418, 7101.32537408966, 7158.856822863618, 6957.8956315654295, 7045.330693584101, 7093.1488221413765, 7112.50212485121, 7129.607871567114, 6237.376262373908, 6253.093301471352, 6317.368263173646, 6324.4940404766585, 6328.7152078157515, 4708.92936605958, 4727.834525791581, 4825.420949486084, 4868.318435418973, 4874.8050077997905, 4935.728534930613, 4967.205247160437, 4980.825671101494, 5000.124978128885, 5144.485551444825], "value": 4326.380264296054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.7090029022284, 313.8571949762858, 321.25949685973836, 321.90825614699816, 322.57903436016016, 4859.465458799529, 4867.955458707343, 4882.316475693401, 4893.632977526682, 4900.411950565928, 4563.064571762789, 4642.143142742896, 4700.717956922578, 4718.504557021515, 4806.255030470274, 3712.8700495482663, 3718.219173973469, 3744.157564547982, 3851.114243723945, 3874.535055793309, 3816.5610954740146, 3848.461215429828, 3852.7863722927327, 3873.128546077124, 3878.146807702301, 3619.5475565554307, 3821.713371497135, 3829.8468061277517, 3833.0609000794707, 3853.344931361661, 3742.925141497155, 3784.26206889658, 3785.848566057354, 3793.753406028627, 3806.4861243732294, 3337.5327454156436, 3337.8164200968936, 3346.113279980807, 3349.844303715214, 3351.329734053199, 4656.438958572771, 4670.579647831712, 4712.952870471286, 4721.6458765592715, 4750.406199225097, 4213.536510983789, 4357.1721372939355, 4430.889227769299, 4449.132419178261, 4453.79957901892, 5071.934893672334, 5083.720395378253, 5087.79648814047, 5089.770960306758, 5109.033022286447, 3770.754900931458, 3787.7159213058853, 3791.8104094795426, 3795.0, 3812.2756676231706, 5113.642045056848, 5324.334458192765, 5361.865953351158, 5375.381831089397, 5411.756470958816, 3730.806142034577, 3735.7945313007504, 3747.744505590658, 3755.9061023474087, 3767.3030489359558, 3807.790571518593, 3809.9903525565746, 3816.8473261069803, 3819.6753275971296, 3822.2737679840743, 4232.0, 4372.759498227628, 4386.363977223285, 4387.868363949086, 4396.648268138541, 5046.7476626168545, 5071.39143302806, 5083.847484575469, 5087.389513258433, 5088.567471764942, 1267.4423253768311, 1332.8933685305346, 1339.1161833190242, 1352.2224720785587, 1357.2263809628614, 832.0820508727442, 858.2447446247387, 860.1484530314943, 860.2408075485647, 934.5140526926097, 4458.286674132123, 4485.865424037284, 4490.57339552742, 4497.775111244425, 4533.52397998212, 5171.456997015259, 5173.430922598511, 5193.714345711022, 5195.272661827347, 5203.375594928632, 4353.281708518122, 4479.708818926824, 4482.350059241392, 4482.977585112054, 4490.932636010462, 2735.493933622286, 2746.835189888613, 2752.848593327346, 2767.7370649788236, 2771.8198317109322, 4851.223804191312, 4873.31773551703, 4932.975335123301, 4937.703737775673, 4961.0, 5063.215201643678, 5296.867578310573, 5389.736310749495, 5390.816719228718, 5424.701641409761, 4985.476524964899, 4998.500149984972, 5018.723970181675, 5022.970291090391, 5058.721770302595, 5269.780179113254, 5306.416294207557, 5325.733713314241, 5363.302770639792, 5380.973095134499, 5003.899922001467, 5191.636585438983, 5197.402298735694, 5204.375474943031, 5206.869828254324, 4979.775910083982, 4986.576141028053, 5011.84964451067, 5048.293238946624, 5059.443461219336, 3721.609231030811, 3728.366177749735, 3733.3280009598534, 3737.9252414951006, 3748.8687895923513, 5121.385433747974, 5205.219217117311, 5223.764930578057, 5247.475252474722, 5258.684478931276, 4990.128701736849, 5043.268726034631, 5090.440051594248, 5111.948880511147, 5136.30659860914, 4966.18058020437, 5074.5940324774665, 5124.41069277023, 5137.152369858932, 5156.071907056766, 4840.540148685869, 4862.659613826998, 5055.180135151416, 5060.645754797129, 5062.797488100435, 5096.592272618256, 5117.5394214520875, 5130.743462826918, 5139.537441630271, 5140.640155189101, 4987.451380348231, 5007.924881126859, 5030.698158110525, 5031.0, 5036.244563315532], "value": 3859.616174336391, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.7720452250757, 697.5709938387893, 698.4552049401467, 706.2584286499175, 759.5632511306001, 11736.29582225066, 11800.58697945571, 11839.0, 11864.22882512636, 12146.939265303672, 11207.719807004829, 11244.0, 11252.26860254085, 11257.155713321492, 11259.718507037307, 669.0733334331961, 818.7666515043214, 845.045099038086, 846.1073567386405, 848.6605357856876, 842.7303262955857, 849.1041950741965, 849.9150084991483, 850.5832142250284, 850.8851305073829, 905.2803021597846, 907.2016625369665, 907.4237858959575, 908.6410867707252, 908.6728777640077, 712.7647876200841, 876.7501262140323, 902.4720538484994, 903.3134817538652, 907.0249481807084, 668.6723505482328, 671.7480944645757, 672.5527524196403, 673.3132205150768, 673.3569441183707, 11695.415229238504, 11772.0, 11794.174407791457, 11806.291622502677, 11822.940885295518, 11310.09519238459, 12060.457279422359, 12324.938375308157, 12366.62900112998, 12796.0, 11274.830877536844, 11441.199116061878, 11915.642530724092, 11931.0, 12403.25580465175, 4128.380742888561, 4191.161767646452, 4224.324108142682, 4327.545607711208, 4377.34339849022, 44862.55137448617, 48613.270800938015, 50150.74924625354, 50298.0, 50403.24395134076, 9784.266180036526, 9922.751931201634, 9974.750631234132, 10035.197184225244, 10048.899511004796, 17273.309067637405, 17275.827241727675, 17291.0, 17294.481165565052, 17329.7400538992, 6439.967800160969, 6476.773312934025, 6511.479081673455, 6534.019897015486, 6798.626075565891, 3653.725970552219, 3687.041369244016, 3706.4996225509212, 3764.171882185915, 3794.753341032824, 2947.1305964740454, 2989.1032690192856, 3034.9544756828664, 3046.84765761711, 3049.1157564306545, 539.2181337061198, 545.4109561673383, 547.0836349115216, 551.8647931256787, 553.7618823905759, 521.916493361068, 574.5834270154188, 576.2048373244979, 578.3869098755249, 581.6451964301773, 6978.205575781736, 7229.638518074075, 7304.306090921354, 7328.377087947584, 7446.702131914771, 502.2491375393737, 543.5732949634597, 544.3032917865139, 550.6998685716294, 562.6624025584616, 3550.378683730337, 3598.4242521196484, 3613.3676606594267, 3628.6552777486627, 3699.2440631729532, 52772.434055692815, 55291.0, 55445.0, 56129.0, 56382.43617563854, 50161.74919125454, 50237.497625024014, 50945.74527127341, 51448.74275628598, 52851.47148528542, 42486.78756606197, 43378.34932476015, 43625.34561981573, 47265.76367118143, 48073.75963120162, 7718.112417071884, 7723.5002839521985, 7809.921900781147, 7909.564973926489, 8197.672093116447, 30599.0, 31212.375752485277, 31903.202419939687, 32098.35803283968, 32443.18892027718, 43366.783166083966, 43581.128377432906, 43720.0, 44167.77916110399, 44462.55537444713, 9936.503174841373, 9989.700308990741, 11145.331280123219, 11255.099592032782, 11318.547258109584, 12103.092268079754, 12218.87781122213, 12364.319962402154, 12514.374281285716, 12560.120791544505, 10930.209470862828, 10966.767971713876, 11002.174836887105, 11393.316401015965, 11778.29330240154, 11118.777624447628, 11468.713282168013, 11512.59705910289, 11581.88418115808, 11673.941630291794, 10880.836787448354, 11021.944890275498, 11157.553697851996, 11327.830082548933, 11414.48634811419, 9691.660791872533, 9774.85337719949, 9978.650747224103, 10097.19222462216, 10407.115395191493, 9360.20438262728, 9396.95301523488, 9495.0, 9504.243769306824, 9543.236541076836], "value": 6081.466343431755, "unit": "score"}], "name": "dromaeo_css", "value": 6479.935332146375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 113.0, 112.0, 114.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 136.0, 159.0, 214.0, 131.0, 155.0, 154.0, 135.0, 184.0, 133.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 165.0, 163.0, 163.0, 168.0, 164.0, 164.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 76.0, 158.0, 76.0, 76.0, 75.0, 76.0, 130.0, 77.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 151.0, 92.0, 93.0, 93.0, 125.0, 93.0, 93.0, 116.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.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, 65.0, 65.0, 66.0, 66.0, 64.0, 66.0, 66.0, 63.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 65.0, 66.0, 64.0, 64.0, 66.0, 66.0, 67.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 81.0, 82.0, 82.0, 84.0, 84.0, 164.0, 83.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 130.0, 137.0, 128.0, 127.0, 140.0, 139.0, 135.0, 159.0, 132.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 167.0, 164.0, 164.0, 172.0, 167.0, 168.0, 166.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 65.0, 65.0, 66.0, 66.0, 66.0, 64.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1576.2999999999997, "alertThreshold": 2.0}]} 21:16:18 INFO - Return code: 0 21:16:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:16:18 ERROR - # TBPL SUCCESS # 21:16:18 INFO - Running post-action listener: _resource_record_post_action 21:16:18 INFO - ##### 21:16:18 INFO - ##### Finished run-tests step (success) 21:16:18 INFO - ##### 21:16:18 INFO - Running post-run listener: _resource_record_post_run 21:16:18 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532520960; Read time: 12; Write time: 477296 21:16:18 INFO - TinderboxPrint: CPU usage
13.1% 21:16:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:16:18 INFO - TinderboxPrint: I/O write bytes / time
532,520,960 / 477,296 21:16:18 INFO - TinderboxPrint: CPU idle
8,326.5 (86.9%) 21:16:18 INFO - TinderboxPrint: CPU user
1,214.0 (12.7%) 21:16:18 INFO - TinderboxPrint: Swap in / out
0 / 0 21:16:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236232704; Read time: 0; Write time: 244908 21:16:18 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295976960; Read time: 12; Write time: 232360 21:16:18 INFO - Running post-run listener: _upload_blobber_files 21:16:18 INFO - Blob upload gear active. 21:16:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:16:18 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 21:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:16:19 INFO - (blobuploader) - INFO - Open directory for files ... 21:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:16:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:23 INFO - (blobuploader) - INFO - Done attempting. 21:16:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:16:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:16:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:23 INFO - (blobuploader) - INFO - Done attempting. 21:16:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:16:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:16:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:24 INFO - (blobuploader) - INFO - Done attempting. 21:16:24 INFO - (blobuploader) - INFO - Iteration through files over. 21:16:24 INFO - Return code: 0 21:16:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:16:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:16:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d6bbc288a6e2abc299bc9fe868ec1433e7592b68fe2b92abb41ba4182049d3fa28f8d3c3f51290c1a23c2f6ca20b15562d8e490aedfea71184c260df95523b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/625296ab0b7249b378bef98a798c364ad745dc5741390116bd3b11f2efe9d6d170e6baed3cc52f753b277dcd5b749899ccdb23df5d055ea48c0cfec591dc0223", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5864177a8456a3b9df5479efc7510ca60c53d86f45347b6df445fe88419247c212b21d4f99b09162414db3cdc0f32fd8b4f4557e182d26140fbbe4ba0b3ae49"} 21:16:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:16:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:16:24 INFO - Contents: 21:16:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d6bbc288a6e2abc299bc9fe868ec1433e7592b68fe2b92abb41ba4182049d3fa28f8d3c3f51290c1a23c2f6ca20b15562d8e490aedfea71184c260df95523b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/625296ab0b7249b378bef98a798c364ad745dc5741390116bd3b11f2efe9d6d170e6baed3cc52f753b277dcd5b749899ccdb23df5d055ea48c0cfec591dc0223", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5864177a8456a3b9df5479efc7510ca60c53d86f45347b6df445fe88419247c212b21d4f99b09162414db3cdc0f32fd8b4f4557e182d26140fbbe4ba0b3ae49"} 21:16:24 INFO - Running post-run listener: copy_logs_to_upload_dir 21:16:24 INFO - Copying logs to upload dir... 21:16:24 INFO - mkdir: /builds/slave/test/build/upload/logs 21:16:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.769932 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-17 21:16:24.575556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 21:16:24.578902) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d6bbc288a6e2abc299bc9fe868ec1433e7592b68fe2b92abb41ba4182049d3fa28f8d3c3f51290c1a23c2f6ca20b15562d8e490aedfea71184c260df95523b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/625296ab0b7249b378bef98a798c364ad745dc5741390116bd3b11f2efe9d6d170e6baed3cc52f753b277dcd5b749899ccdb23df5d055ea48c0cfec591dc0223", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5864177a8456a3b9df5479efc7510ca60c53d86f45347b6df445fe88419247c212b21d4f99b09162414db3cdc0f32fd8b4f4557e182d26140fbbe4ba0b3ae49"} build_url:https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/HpIpRJ-0RZGrbdcZ2MME6Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d6bbc288a6e2abc299bc9fe868ec1433e7592b68fe2b92abb41ba4182049d3fa28f8d3c3f51290c1a23c2f6ca20b15562d8e490aedfea71184c260df95523b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/625296ab0b7249b378bef98a798c364ad745dc5741390116bd3b11f2efe9d6d170e6baed3cc52f753b277dcd5b749899ccdb23df5d055ea48c0cfec591dc0223", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5864177a8456a3b9df5479efc7510ca60c53d86f45347b6df445fe88419247c212b21d4f99b09162414db3cdc0f32fd8b4f4557e182d26140fbbe4ba0b3ae49"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 21:16:24.605905) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:16:24.606680) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463543536.672764-592812030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004384 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 21:16:24.689104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 21:16:24.689921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 21:16:24.690588) ========= ========= Total master_lag: 0.17 =========