builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1464113583.83 results: success (0) buildid: 20160524083109 builduid: dcb1f2a23119413197d2f4c1c8b6fde3 revision: 05adfc869721ffaa57a0b341bd56d78d9f5867f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:03.825578) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:03.826026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:03.826323) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:03.843503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:03.843863) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 11:13:05-- 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% 50.6M=0s 2016-05-24 11:13:05 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121959 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:03.980101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:03.980442) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016990 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:04.032333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:04.032714) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 05adfc869721ffaa57a0b341bd56d78d9f5867f4 --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 05adfc869721ffaa57a0b341bd56d78d9f5867f4 --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=e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 11:13:05,356 truncating revision to first 12 chars 2016-05-24 11:13:05,356 Setting DEBUG logging. 2016-05-24 11:13:05,356 attempt 1/10 2016-05-24 11:13:05,356 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/05adfc869721?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 11:13:05,951 unpacking tar archive at: fx-team-05adfc869721/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:04.982265) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:04.982592) ========= script_repo_revision: 05adfc869721ffaa57a0b341bd56d78d9f5867f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:04.982997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:04.983265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 11:13:04.998740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-24 11:13:04.999097) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:13:06 INFO - MultiFileLogger online at 20160524 11:13:06 in /builds/slave/test 11:13:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:13:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:13:06 INFO - {'append_to_log': False, 11:13:06 INFO - 'base_work_dir': '/builds/slave/test', 11:13:06 INFO - 'blob_upload_branch': 'Fx-Team', 11:13:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:13:06 INFO - 'branch': 'Fx-Team', 11:13:06 INFO - 'buildbot_json_path': 'buildprops.json', 11:13:06 INFO - 'config_files': ('talos/linux_config.py',), 11:13:06 INFO - 'default_actions': ('clobber', 11:13:06 INFO - 'read-buildbot-config', 11:13:06 INFO - 'download-and-extract', 11:13:06 INFO - 'populate-webroot', 11:13:06 INFO - 'create-virtualenv', 11:13:06 INFO - 'install', 11:13:06 INFO - 'run-tests'), 11:13:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:13:06 INFO - 'download_minidump_stackwalk': True, 11:13:06 INFO - 'download_symbols': 'ondemand', 11:13:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:13:06 INFO - 'tooltool.py': '/tools/tooltool.py', 11:13:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:13:06 INFO - '/tools/misc-python/virtualenv.py')}, 11:13:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:13:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:13:06 INFO - 'installer_path': 'installer.exe', 11:13:06 INFO - 'log_level': 'info', 11:13:06 INFO - 'log_name': 'talos', 11:13:06 INFO - 'log_to_console': True, 11:13:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:13:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:13:06 INFO - 'opt_config_files': (), 11:13:06 INFO - 'pip_index': False, 11:13:06 INFO - 'sps_profile': False, 11:13:06 INFO - 'sps_profile_interval': 0, 11:13:06 INFO - 'suite': 'dromaeojs', 11:13:06 INFO - 'system_bits': '32', 11:13:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:13:06 INFO - 'title': 'talos-linux64-ix-067', 11:13:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:13:06 INFO - 'use_talos_json': True, 11:13:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:13:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:13:06 INFO - 'work_dir': 'build'} 11:13:06 INFO - ##### 11:13:06 INFO - ##### Running clobber step. 11:13:06 INFO - ##### 11:13:06 INFO - Running pre-action listener: _resource_record_pre_action 11:13:06 INFO - Running main action method: clobber 11:13:06 INFO - rmtree: /builds/slave/test/build 11:13:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:13:06 INFO - Running post-action listener: _resource_record_post_action 11:13:06 INFO - ##### 11:13:06 INFO - ##### Finished clobber step (success) 11:13:06 INFO - ##### 11:13:06 INFO - ##### 11:13:06 INFO - ##### Running read-buildbot-config step. 11:13:06 INFO - ##### 11:13:06 INFO - Running pre-action listener: _resource_record_pre_action 11:13:06 INFO - Running main action method: read_buildbot_config 11:13:06 INFO - Using buildbot properties: 11:13:06 INFO - { 11:13:06 INFO - "project": "", 11:13:06 INFO - "product": "firefox", 11:13:06 INFO - "script_repo_revision": "production", 11:13:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:13:06 INFO - "repository": "", 11:13:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:13:06 INFO - "buildid": "20160524083109", 11:13:06 INFO - "pgo_build": "True", 11:13:06 INFO - "basedir": "/builds/slave/test", 11:13:06 INFO - "buildnumber": 1181, 11:13:06 INFO - "slavename": "talos-linux64-ix-067", 11:13:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:13:06 INFO - "platform": "ubuntu64_hw", 11:13:06 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:13:06 INFO - "branch": "fx-team", 11:13:06 INFO - "repo_path": "integration/fx-team", 11:13:06 INFO - "revision": "05adfc869721ffaa57a0b341bd56d78d9f5867f4", 11:13:06 INFO - "stage_platform": "linux64-pgo", 11:13:06 INFO - "builduid": "dcb1f2a23119413197d2f4c1c8b6fde3", 11:13:06 INFO - "slavebuilddir": "test" 11:13:06 INFO - } 11:13:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:13:06 INFO - Running post-action listener: _resource_record_post_action 11:13:06 INFO - ##### 11:13:06 INFO - ##### Finished read-buildbot-config step (success) 11:13:06 INFO - ##### 11:13:06 INFO - ##### 11:13:06 INFO - ##### Running download-and-extract step. 11:13:06 INFO - ##### 11:13:06 INFO - Running pre-action listener: _resource_record_pre_action 11:13:06 INFO - Running main action method: download_and_extract 11:13:06 INFO - mkdir: /builds/slave/test/build/tests 11:13:06 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')]} 11:13:06 INFO - https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:13:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:13:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:13:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:07 INFO - Downloaded 1361 bytes. 11:13:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:13:07 INFO - Using the following test package requirements: 11:13:07 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:13:07 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:13:07 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:13:07 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:07 INFO - u'jsshell-linux-x86_64.zip'], 11:13:07 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:13:07 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:13:07 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:13:07 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:13:07 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:13:07 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:13:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:13:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:13: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')]} 11:13:07 INFO - https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:13:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:13:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:13:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:08 INFO - Downloaded 24416797 bytes. 11:13:08 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'] 11:13:08 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 11:13:10 INFO - Return code: 0 11:13:10 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 11:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:10 INFO - https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:13:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:13:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:13:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:11 INFO - Downloaded 24416797 bytes. 11:13:11 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'] 11:13:11 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 11:13:12 INFO - Return code: 0 11:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:12 INFO - https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:13 INFO - Downloaded 10840359 bytes. 11:13:13 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'] 11:13:13 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 11:13:14 INFO - Return code: 0 11:13:14 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')]} 11:13:14 INFO - https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:13:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:13:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:13:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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 11:13:15 INFO - Downloaded 58616588 bytes. 11:13:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:13:15 INFO - mkdir: /builds/slave/test/properties 11:13:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:13:15 INFO - Writing to file /builds/slave/test/properties/build_url 11:13:15 INFO - Contents: 11:13:15 INFO - build_url:https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:13:16 INFO - Running post-action listener: _resource_record_post_action 11:13:16 INFO - Running post-action listener: set_extra_try_arguments 11:13:16 INFO - ##### 11:13:16 INFO - ##### Finished download-and-extract step (success) 11:13:16 INFO - ##### 11:13:16 INFO - ##### 11:13:16 INFO - ##### Running populate-webroot step. 11:13:16 INFO - ##### 11:13:16 INFO - Running pre-action listener: _resource_record_pre_action 11:13:16 INFO - Running main action method: populate_webroot 11:13:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:13:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:13:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:13:16 INFO - '--tppagecycles', 11:13:16 INFO - '7'], 11:13:16 INFO - 'tests': ['tsvgm']}}, 11:13:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:13:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:13:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:13:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:13:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:16 INFO - 'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:16 INFO - 'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['damp', 'tps']}, 11:13:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:16 INFO - 'tests': ['damp', 'tps']}, 11:13:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['dromaeo_dom']}, 11:13:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['a11yr', 11:13:16 INFO - 'ts_paint', 11:13:16 INFO - 'tpaint', 11:13:16 INFO - 'sessionrestore', 11:13:16 INFO - 'sessionrestore_no_auto_restore', 11:13:16 INFO - 'tabpaint']}, 11:13:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:13:16 INFO - 'ts_paint', 11:13:16 INFO - 'tpaint', 11:13:16 INFO - 'sessionrestore', 11:13:16 INFO - 'sessionrestore_no_auto_restore', 11:13:16 INFO - 'tabpaint']}, 11:13:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:13:16 INFO - 'ts_paint', 11:13:16 INFO - 'tpaint', 11:13:16 INFO - 'sessionrestore', 11:13:16 INFO - 'sessionrestore_no_auto_restore', 11:13:16 INFO - 'tabpaint']}, 11:13:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:13:16 INFO - 'ts_paint', 11:13:16 INFO - 'tpaint', 11:13:16 INFO - 'sessionrestore', 11:13:16 INFO - 'sessionrestore_no_auto_restore', 11:13:16 INFO - 'tabpaint']}, 11:13:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['a11yr', 11:13:16 INFO - 'ts_paint', 11:13:16 INFO - 'tpaint', 11:13:16 INFO - 'sessionrestore', 11:13:16 INFO - 'sessionrestore_no_auto_restore', 11:13:16 INFO - 'tabpaint']}, 11:13:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['a11yr', 11:13:16 INFO - 'ts_paint', 11:13:16 INFO - 'tpaint', 11:13:16 INFO - 'sessionrestore', 11:13:16 INFO - 'sessionrestore_no_auto_restore', 11:13:16 INFO - 'tabpaint']}, 11:13:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['tsvgx', 11:13:16 INFO - 'tsvgr_opacity', 11:13:16 INFO - 'tart', 11:13:16 INFO - 'tscrollx', 11:13:16 INFO - 'cart']}, 11:13:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:13:16 INFO - 'tsvgr_opacity', 11:13:16 INFO - 'tart', 11:13:16 INFO - 'tscrollx', 11:13:16 INFO - 'cart']}, 11:13:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:16 INFO - 'talos_options': ['--disable-e10s'], 11:13:16 INFO - 'tests': ['tp5o']}, 11:13:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:16 INFO - 'tests': ['tp5o']}, 11:13:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:16 INFO - 'talos_options': ['--disable-e10s', 11:13:16 INFO - '--xperf_path', 11:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:16 INFO - 'tests': ['tp5n']}, 11:13:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:16 INFO - 'talos_options': ['--xperf_path', 11:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:16 INFO - 'tests': ['tp5n']}}, 11:13:16 INFO - 'talos.zip': {'path': '', 11:13:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:13:16 INFO - Running post-action listener: _resource_record_post_action 11:13:16 INFO - ##### 11:13:16 INFO - ##### Finished populate-webroot step (success) 11:13:16 INFO - ##### 11:13:16 INFO - ##### 11:13:16 INFO - ##### Running create-virtualenv step. 11:13:16 INFO - ##### 11:13:16 INFO - Running pre-action listener: _resource_record_pre_action 11:13:16 INFO - Running main action method: create_virtualenv 11:13:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:13:16 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 11:13:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:13:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:16 INFO - Using real prefix '/usr' 11:13:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:13:17 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:19 INFO - Installing pip.................done. 11:13:19 INFO - Return code: 0 11:13:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:19 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:19 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 11:13:19 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 11:13:19 INFO - Using env: {'DISPLAY': ':0', 11:13:19 INFO - 'HOME': '/home/cltbld', 11:13:19 INFO - 'LANG': 'en_US.UTF-8', 11:13:19 INFO - 'LANGUAGE': 'en_US:en', 11:13:19 INFO - 'LOGNAME': 'cltbld', 11:13:19 INFO - 'MAIL': '/var/mail/cltbld', 11:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:19 INFO - 'MOZ_NO_REMOTE': '1', 11:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:19 INFO - 'NO_EM_RESTART': '1', 11:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:19 INFO - 'PWD': '/builds/slave/test', 11:13:19 INFO - 'SHELL': '/bin/bash', 11:13:19 INFO - 'SHLVL': '1', 11:13:19 INFO - 'TERM': 'linux', 11:13:19 INFO - 'TMOUT': '86400', 11:13:19 INFO - 'USER': 'cltbld', 11:13:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:19 INFO - '_': '/tools/buildbot/bin/python'} 11:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:19 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 11:13:19 INFO - Cleaning up... 11:13:19 INFO - Return code: 0 11:13:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:19 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:19 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 11:13:19 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 11:13:19 INFO - Using env: {'DISPLAY': ':0', 11:13:19 INFO - 'HOME': '/home/cltbld', 11:13:19 INFO - 'LANG': 'en_US.UTF-8', 11:13:19 INFO - 'LANGUAGE': 'en_US:en', 11:13:19 INFO - 'LOGNAME': 'cltbld', 11:13:19 INFO - 'MAIL': '/var/mail/cltbld', 11:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:19 INFO - 'MOZ_NO_REMOTE': '1', 11:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:19 INFO - 'NO_EM_RESTART': '1', 11:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:19 INFO - 'PWD': '/builds/slave/test', 11:13:19 INFO - 'SHELL': '/bin/bash', 11:13:19 INFO - 'SHLVL': '1', 11:13:19 INFO - 'TERM': 'linux', 11:13:19 INFO - 'TMOUT': '86400', 11:13:19 INFO - 'USER': 'cltbld', 11:13:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:19 INFO - '_': '/tools/buildbot/bin/python'} 11:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:19 INFO - Downloading/unpacking psutil>=3.1.1 11:13:19 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 11:13:19 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 11:13:19 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 11:13:19 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 11:13:19 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 11:13:19 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 11:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:21 INFO - Installing collected packages: psutil 11:13:21 INFO - Running setup.py install for psutil 11:13:21 INFO - building 'psutil._psutil_linux' extension 11:13:21 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 11:13:22 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 11:13:22 INFO - building 'psutil._psutil_posix' extension 11:13:22 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 11:13:22 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 11:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:22 INFO - Successfully installed psutil 11:13:22 INFO - Cleaning up... 11:13:22 INFO - Return code: 0 11:13:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:22 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:22 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 11:13:22 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 11:13:22 INFO - Using env: {'DISPLAY': ':0', 11:13:22 INFO - 'HOME': '/home/cltbld', 11:13:22 INFO - 'LANG': 'en_US.UTF-8', 11:13:22 INFO - 'LANGUAGE': 'en_US:en', 11:13:22 INFO - 'LOGNAME': 'cltbld', 11:13:22 INFO - 'MAIL': '/var/mail/cltbld', 11:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:22 INFO - 'MOZ_NO_REMOTE': '1', 11:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:22 INFO - 'NO_EM_RESTART': '1', 11:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:22 INFO - 'PWD': '/builds/slave/test', 11:13:22 INFO - 'SHELL': '/bin/bash', 11:13:22 INFO - 'SHLVL': '1', 11:13:22 INFO - 'TERM': 'linux', 11:13:22 INFO - 'TMOUT': '86400', 11:13:22 INFO - 'USER': 'cltbld', 11:13:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:22 INFO - '_': '/tools/buildbot/bin/python'} 11:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:13:22 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 11:13:22 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 11:13:22 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 11:13:22 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 11:13:22 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 11:13:22 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 11:13:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:13:24 INFO - Installing collected packages: mozsystemmonitor 11:13:24 INFO - Running setup.py install for mozsystemmonitor 11:13:24 INFO - Successfully installed mozsystemmonitor 11:13:24 INFO - Cleaning up... 11:13:24 INFO - Return code: 0 11:13:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:24 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')]} 11:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:24 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')]} 11:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:24 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:24 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 11:13:24 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 11:13:24 INFO - Using env: {'DISPLAY': ':0', 11:13:24 INFO - 'HOME': '/home/cltbld', 11:13:24 INFO - 'LANG': 'en_US.UTF-8', 11:13:24 INFO - 'LANGUAGE': 'en_US:en', 11:13:24 INFO - 'LOGNAME': 'cltbld', 11:13:24 INFO - 'MAIL': '/var/mail/cltbld', 11:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:24 INFO - 'MOZ_NO_REMOTE': '1', 11:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:24 INFO - 'NO_EM_RESTART': '1', 11:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:24 INFO - 'PWD': '/builds/slave/test', 11:13:24 INFO - 'SHELL': '/bin/bash', 11:13:24 INFO - 'SHLVL': '1', 11:13:24 INFO - 'TERM': 'linux', 11:13:24 INFO - 'TMOUT': '86400', 11:13:24 INFO - 'USER': 'cltbld', 11:13:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:24 INFO - '_': '/tools/buildbot/bin/python'} 11:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:24 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:24 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 11:13:24 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 11:13:24 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 11:13:24 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 11:13:24 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 11:13:24 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 11:13:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:26 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 11:13:26 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 11:13:26 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 11:13:26 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 11:13:26 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 11:13:26 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 11:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:27 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 11:13:27 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 11:13:27 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 11:13:27 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 11:13:27 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 11:13:27 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 11:13:27 INFO - Downloading docopt-0.6.1.tar.gz 11:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:27 INFO - Running setup.py install for blobuploader 11:13:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:27 INFO - Running setup.py install for requests 11:13:28 INFO - Running setup.py install for docopt 11:13:28 INFO - Successfully installed blobuploader requests docopt 11:13:28 INFO - Cleaning up... 11:13:28 INFO - Return code: 0 11:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:28 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:28 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 11:13:28 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 11:13:28 INFO - Using env: {'DISPLAY': ':0', 11:13:28 INFO - 'HOME': '/home/cltbld', 11:13:28 INFO - 'LANG': 'en_US.UTF-8', 11:13:28 INFO - 'LANGUAGE': 'en_US:en', 11:13:28 INFO - 'LOGNAME': 'cltbld', 11:13:28 INFO - 'MAIL': '/var/mail/cltbld', 11:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:28 INFO - 'MOZ_NO_REMOTE': '1', 11:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:28 INFO - 'NO_EM_RESTART': '1', 11:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:28 INFO - 'PWD': '/builds/slave/test', 11:13:28 INFO - 'SHELL': '/bin/bash', 11:13:28 INFO - 'SHLVL': '1', 11:13:28 INFO - 'TERM': 'linux', 11:13:28 INFO - 'TMOUT': '86400', 11:13:28 INFO - 'USER': 'cltbld', 11:13:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:28 INFO - '_': '/tools/buildbot/bin/python'} 11:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:28 INFO - Running setup.py (path:/tmp/pip-Vmcu81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:28 INFO - Running setup.py (path:/tmp/pip-jsTuNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:28 INFO - Running setup.py (path:/tmp/pip-3chK_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:28 INFO - Running setup.py (path:/tmp/pip-Q6UE3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:28 INFO - Running setup.py (path:/tmp/pip-t_T5yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:28 INFO - Running setup.py (path:/tmp/pip-c08iwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:28 INFO - Running setup.py (path:/tmp/pip-76fym7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:28 INFO - Running setup.py (path:/tmp/pip-L6OmLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:29 INFO - Running setup.py (path:/tmp/pip-i3EWEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:29 INFO - Running setup.py (path:/tmp/pip-cB5Nm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:29 INFO - Running setup.py (path:/tmp/pip-aK0iiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:29 INFO - Running setup.py (path:/tmp/pip-iSQdcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:29 INFO - Running setup.py (path:/tmp/pip-eiI1HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:29 INFO - Running setup.py (path:/tmp/pip-xZSpp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:29 INFO - Running setup.py (path:/tmp/pip-qLqt99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:29 INFO - Running setup.py (path:/tmp/pip-TIK6rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:29 INFO - Running setup.py (path:/tmp/pip-Jdi1Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:29 INFO - Running setup.py install for manifestparser 11:13:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:29 INFO - Running setup.py install for mozcrash 11:13:29 INFO - Running setup.py install for mozdebug 11:13:30 INFO - Running setup.py install for mozdevice 11:13:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Running setup.py install for mozfile 11:13:30 INFO - Running setup.py install for mozhttpd 11:13:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Running setup.py install for mozinfo 11:13:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Running setup.py install for mozInstall 11:13:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Running setup.py install for mozleak 11:13:30 INFO - Running setup.py install for mozlog 11:13:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Running setup.py install for moznetwork 11:13:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:30 INFO - Running setup.py install for mozprocess 11:13:30 INFO - Running setup.py install for mozprofile 11:13:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:31 INFO - Running setup.py install for mozrunner 11:13:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:31 INFO - Running setup.py install for mozscreenshot 11:13:31 INFO - Running setup.py install for moztest 11:13:31 INFO - Running setup.py install for mozversion 11:13:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:31 INFO - Cleaning up... 11:13:31 INFO - Return code: 0 11:13:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:31 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')]} 11:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:31 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')]} 11:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:31 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:31 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 11:13:31 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 11:13:31 INFO - Using env: {'DISPLAY': ':0', 11:13:31 INFO - 'HOME': '/home/cltbld', 11:13:31 INFO - 'LANG': 'en_US.UTF-8', 11:13:31 INFO - 'LANGUAGE': 'en_US:en', 11:13:31 INFO - 'LOGNAME': 'cltbld', 11:13:31 INFO - 'MAIL': '/var/mail/cltbld', 11:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:31 INFO - 'MOZ_NO_REMOTE': '1', 11:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:31 INFO - 'NO_EM_RESTART': '1', 11:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:31 INFO - 'PWD': '/builds/slave/test', 11:13:31 INFO - 'SHELL': '/bin/bash', 11:13:31 INFO - 'SHLVL': '1', 11:13:31 INFO - 'TERM': 'linux', 11:13:31 INFO - 'TMOUT': '86400', 11:13:31 INFO - 'USER': 'cltbld', 11:13:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:31 INFO - '_': '/tools/buildbot/bin/python'} 11:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:31 INFO - Running setup.py (path:/tmp/pip-67axRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:31 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)) 11:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:31 INFO - Running setup.py (path:/tmp/pip-QBiuTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:31 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)) 11:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:31 INFO - Running setup.py (path:/tmp/pip-NLATbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:31 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)) 11:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:31 INFO - Running setup.py (path:/tmp/pip-WKL9DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:32 INFO - Running setup.py (path:/tmp/pip-wyBPut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:32 INFO - Running setup.py (path:/tmp/pip-iXQ7dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:32 INFO - Running setup.py (path:/tmp/pip-fhKwmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:32 INFO - Running setup.py (path:/tmp/pip-UzcEZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:32 INFO - Running setup.py (path:/tmp/pip-rGLb0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:32 INFO - Running setup.py (path:/tmp/pip-5cp7Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:32 INFO - Running setup.py (path:/tmp/pip-MyicFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:32 INFO - Running setup.py (path:/tmp/pip-uExBBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:32 INFO - Running setup.py (path:/tmp/pip-Pb2TzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:32 INFO - Running setup.py (path:/tmp/pip-rpIilw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:32 INFO - Running setup.py (path:/tmp/pip-n_syrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:32 INFO - Running setup.py (path:/tmp/pip-3mxzh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:32 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)) 11:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:32 INFO - Running setup.py (path:/tmp/pip-l8EUiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:32 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)) 11:13:32 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)) 11:13:32 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)) 11:13:32 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)) 11:13:32 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)) 11:13:32 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)) 11:13:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:33 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 11:13:33 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 11:13:33 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 11:13:33 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 11:13:33 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 11:13:33 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 11:13:34 INFO - Downloading blessings-1.6.tar.gz 11:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:34 INFO - Installing collected packages: blessings 11:13:34 INFO - Running setup.py install for blessings 11:13:35 INFO - Successfully installed blessings 11:13:35 INFO - Cleaning up... 11:13:35 INFO - Return code: 0 11:13:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:35 INFO - Reading from file tmpfile_stdout 11:13:35 INFO - Current package versions: 11:13:35 INFO - argparse == 1.2.1 11:13:35 INFO - blessings == 1.6 11:13:35 INFO - blobuploader == 1.2.4 11:13:35 INFO - docopt == 0.6.1 11:13:35 INFO - manifestparser == 1.1 11:13:35 INFO - mozInstall == 1.12 11:13:35 INFO - mozcrash == 0.17 11:13:35 INFO - mozdebug == 0.1 11:13:35 INFO - mozdevice == 0.48 11:13:35 INFO - mozfile == 1.2 11:13:35 INFO - mozhttpd == 0.7 11:13:35 INFO - mozinfo == 0.9 11:13:35 INFO - mozleak == 0.1 11:13:35 INFO - mozlog == 3.2 11:13:35 INFO - moznetwork == 0.27 11:13:35 INFO - mozprocess == 0.22 11:13:35 INFO - mozprofile == 0.28 11:13:35 INFO - mozrunner == 6.11 11:13:35 INFO - mozscreenshot == 0.1 11:13:35 INFO - mozsystemmonitor == 0.3 11:13:35 INFO - moztest == 0.7 11:13:35 INFO - mozversion == 1.4 11:13:35 INFO - psutil == 3.1.1 11:13:35 INFO - requests == 1.2.3 11:13:35 INFO - wsgiref == 0.1.2 11:13:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:35 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:35 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 11:13:35 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 11:13:35 INFO - Using env: {'DISPLAY': ':0', 11:13:35 INFO - 'HOME': '/home/cltbld', 11:13:35 INFO - 'LANG': 'en_US.UTF-8', 11:13:35 INFO - 'LANGUAGE': 'en_US:en', 11:13:35 INFO - 'LOGNAME': 'cltbld', 11:13:35 INFO - 'MAIL': '/var/mail/cltbld', 11:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:35 INFO - 'MOZ_NO_REMOTE': '1', 11:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:35 INFO - 'NO_EM_RESTART': '1', 11:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:35 INFO - 'PWD': '/builds/slave/test', 11:13:35 INFO - 'SHELL': '/bin/bash', 11:13:35 INFO - 'SHLVL': '1', 11:13:35 INFO - 'TERM': 'linux', 11:13:35 INFO - 'TMOUT': '86400', 11:13:35 INFO - 'USER': 'cltbld', 11:13:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:35 INFO - '_': '/tools/buildbot/bin/python'} 11:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 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)) 11:13:35 INFO - Cleaning up... 11:13:35 INFO - Return code: 0 11:13:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:35 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:35 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 11:13:35 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 11:13:35 INFO - Using env: {'DISPLAY': ':0', 11:13:35 INFO - 'HOME': '/home/cltbld', 11:13:35 INFO - 'LANG': 'en_US.UTF-8', 11:13:35 INFO - 'LANGUAGE': 'en_US:en', 11:13:35 INFO - 'LOGNAME': 'cltbld', 11:13:35 INFO - 'MAIL': '/var/mail/cltbld', 11:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:35 INFO - 'MOZ_NO_REMOTE': '1', 11:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:35 INFO - 'NO_EM_RESTART': '1', 11:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:35 INFO - 'PWD': '/builds/slave/test', 11:13:35 INFO - 'SHELL': '/bin/bash', 11:13:35 INFO - 'SHLVL': '1', 11:13:35 INFO - 'TERM': 'linux', 11:13:35 INFO - 'TMOUT': '86400', 11:13:35 INFO - 'USER': 'cltbld', 11:13:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:35 INFO - '_': '/tools/buildbot/bin/python'} 11:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:35 INFO - Downloading/unpacking jsonschema 11:13:35 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 11:13:35 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 11:13:35 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 11:13:35 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 11:13:35 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 11:13:35 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 11:13:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:37 INFO - Downloading/unpacking functools32 (from jsonschema) 11:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:37 INFO - warning: no files found matching '*.txt' 11:13:37 INFO - no previously-included directories found matching 'build' 11:13:37 INFO - no previously-included directories found matching 'dist' 11:13:37 INFO - no previously-included directories found matching '.git*' 11:13:37 INFO - Installing collected packages: jsonschema, functools32 11:13:37 INFO - Running setup.py install for functools32 11:13:38 INFO - warning: no files found matching '*.txt' 11:13:38 INFO - no previously-included directories found matching 'build' 11:13:38 INFO - no previously-included directories found matching 'dist' 11:13:38 INFO - no previously-included directories found matching '.git*' 11:13:38 INFO - Successfully installed jsonschema functools32 11:13:38 INFO - Cleaning up... 11:13:38 INFO - Return code: 0 11:13:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:13:38 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')]} 11:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:38 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')]} 11:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:38 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 0x7fac95381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', '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 11:13:38 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 11:13:38 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 11:13:38 INFO - Using env: {'DISPLAY': ':0', 11:13:38 INFO - 'HOME': '/home/cltbld', 11:13:38 INFO - 'LANG': 'en_US.UTF-8', 11:13:38 INFO - 'LANGUAGE': 'en_US:en', 11:13:38 INFO - 'LOGNAME': 'cltbld', 11:13:38 INFO - 'MAIL': '/var/mail/cltbld', 11:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:38 INFO - 'MOZ_NO_REMOTE': '1', 11:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:38 INFO - 'NO_EM_RESTART': '1', 11:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:38 INFO - 'PWD': '/builds/slave/test', 11:13:38 INFO - 'SHELL': '/bin/bash', 11:13:38 INFO - 'SHLVL': '1', 11:13:38 INFO - 'TERM': 'linux', 11:13:38 INFO - 'TMOUT': '86400', 11:13:38 INFO - 'USER': 'cltbld', 11:13:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:38 INFO - '_': '/tools/buildbot/bin/python'} 11:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:38 INFO - Downloading/unpacking flake8 11:13:38 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 11:13:38 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 11:13:38 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 11:13:38 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 11:13:38 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 11:13:38 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 11:13:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:13:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:13:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 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 11:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:40 INFO - no previously-included directories found matching 'docs/_build' 11:13:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:13:41 INFO - Running setup.py install for pep8 11:13:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:41 INFO - no previously-included directories found matching 'docs/_build' 11:13:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:13:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:13:41 INFO - Cleaning up... 11:13:41 INFO - Return code: 0 11:13:41 INFO - Running post-action listener: _resource_record_post_action 11:13:41 INFO - Running post-action listener: _start_resource_monitoring 11:13:41 INFO - Starting resource monitoring. 11:13:41 INFO - ##### 11:13:41 INFO - ##### Finished create-virtualenv step (success) 11:13:41 INFO - ##### 11:13:41 INFO - ##### 11:13:41 INFO - ##### Running install step. 11:13:41 INFO - ##### 11:13:41 INFO - Running pre-action listener: _resource_record_pre_action 11:13:41 INFO - Running main action method: install 11:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:41 INFO - Reading from file tmpfile_stdout 11:13:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:41 INFO - Reading from file tmpfile_stdout 11:13:41 INFO - Output received: 11:13:41 INFO - Usage: mozinstall [options] installer 11:13:41 INFO - Options: 11:13:41 INFO - -h, --help show this help message and exit 11:13:41 INFO - -d DEST, --destination=DEST 11:13:41 INFO - Directory to install application into. [default: 11:13:41 INFO - "/builds/slave/test"] 11:13:41 INFO - --app=APP Application being installed. [default: firefox] 11:13:41 INFO - mkdir: /builds/slave/test/build/application 11:13:41 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'] 11:13:41 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 11:13:58 INFO - Reading from file tmpfile_stdout 11:13:58 INFO - Output received: 11:13:58 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:58 INFO - Running post-action listener: _resource_record_post_action 11:13:58 INFO - ##### 11:13:58 INFO - ##### Finished install step (success) 11:13:58 INFO - ##### 11:13:58 INFO - ##### 11:13:58 INFO - ##### Running run-tests step. 11:13:58 INFO - ##### 11:13:58 INFO - Running pre-action listener: _resource_record_pre_action 11:13:58 INFO - Running main action method: run_tests 11:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:58 INFO - Python 2.7.3 11:13:58 INFO - Return code: 0 11:13:58 INFO - grabbing minidump binary from tooltool 11:13: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')]} 11:13:58 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 0x19e89c0>, '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 0x19e98c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:58 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 11:13:58 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 11:13:58 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 11:13:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:58 INFO - Return code: 0 11:13:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:13:59 INFO - Return code: 0 11:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 11:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 11:13:59 INFO - Using env: {'DISPLAY': ':0', 11:13:59 INFO - 'HOME': '/home/cltbld', 11:13:59 INFO - 'LANG': 'en_US.UTF-8', 11:13:59 INFO - 'LANGUAGE': 'en_US:en', 11:13:59 INFO - 'LOGNAME': 'cltbld', 11:13:59 INFO - 'MAIL': '/var/mail/cltbld', 11:13:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:59 INFO - 'MOZ_NO_REMOTE': '1', 11:13:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:59 INFO - 'NO_EM_RESTART': '1', 11:13:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:59 INFO - 'PWD': '/builds/slave/test', 11:13:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:59 INFO - 'SHELL': '/bin/bash', 11:13:59 INFO - 'SHLVL': '1', 11:13:59 INFO - 'TERM': 'linux', 11:13:59 INFO - 'TMOUT': '86400', 11:13:59 INFO - 'USER': 'cltbld', 11:13:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066', 11:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:59 INFO - '_': '/tools/buildbot/bin/python'} 11:13:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 11:13:59 INFO - mozversion application_buildid: 20160524083109 11:13:59 INFO - mozversion application_changeset: 05adfc869721ffaa57a0b341bd56d78d9f5867f4 11:13:59 INFO - mozversion application_display_name: Nightly 11:13:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:59 INFO - mozversion application_name: Firefox 11:13:59 INFO - mozversion application_remotingname: firefox 11:13:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:13:59 INFO - mozversion application_vendor: Mozilla 11:13:59 INFO - mozversion application_version: 49.0a1 11:13:59 INFO - mozversion platform_buildid: 20160524083109 11:13:59 INFO - mozversion platform_changeset: 05adfc869721ffaa57a0b341bd56d78d9f5867f4 11:13:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:13:59 INFO - mozversion platform_version: 49.0a1 11:13:59 INFO - using testdate: 1464113639 11:13:59 INFO - actual date: 1464113639 11:13:59 INFO - starting webserver on 'localhost:35926' 11:13:59 INFO - SUITE-START | Running 2 tests 11:13:59 INFO - TEST-START | dromaeo_css 11:13:59 INFO - operating with platform_type : linux_ 11:13:59 INFO - Initialising browser for dromaeo_css test... 11:13:59 INFO - TEST-INFO | started process 7344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMK4A_/profile http://localhost:35926/getInfo.html) 11:14:03 INFO - PROCESS | 7344 | __metrics Screen width/height:1600/1200 11:14:03 INFO - PROCESS | 7344 | colorDepth:24 11:14:03 INFO - PROCESS | 7344 | Browser inner width/height: 1024/697 11:14:03 INFO - PROCESS | 7344 | __metrics 11:14:03 ERROR - PROCESS | 7344 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:14:04 INFO - TEST-INFO | 7344: exit 0 11:14:04 INFO - Browser initialized. 11:14:04 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:04 INFO - TEST-INFO | started process 7425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMK4A_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:16 INFO - PROCESS | 7425 | RSS: Main: 153198592 11:14:16 INFO - PROCESS | 7425 | 11:15:07 INFO - PROCESS | 7425 | 1464113707499 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] 11:17:15 INFO - PROCESS | 7425 | Cycle 1(1): loaded http://localhost:35926/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35926/tests/dromaeo/cssquery-ext.html) 11:17:16 INFO - PROCESS | 7425 | RSS: Main: 250384384 11:17:16 INFO - PROCESS | 7425 | 11:20:18 INFO - PROCESS | 7425 | Cycle 1(1): loaded http://localhost:35926/tests/dromaeo/cssquery-ext.html (next: http://localhost:35926/tests/dromaeo/cssquery-jquery.html) 11:20:19 INFO - PROCESS | 7425 | RSS: Main: 238292992 11:20:19 INFO - PROCESS | 7425 | 11:23:21 INFO - PROCESS | 7425 | Cycle 1(1): loaded http://localhost:35926/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35926/tests/dromaeo/cssquery-mootools.html) 11:23:21 INFO - PROCESS | 7425 | RSS: Main: 236052480 11:23:21 INFO - PROCESS | 7425 | 11:26:23 INFO - PROCESS | 7425 | Cycle 1(1): loaded http://localhost:35926/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35926/tests/dromaeo/cssquery-prototype.html) 11:26:24 INFO - PROCESS | 7425 | RSS: Main: 233025536 11:26:24 INFO - PROCESS | 7425 | 11:29:27 INFO - PROCESS | 7425 | Cycle 1(1): loaded http://localhost:35926/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35926/tests/dromaeo/cssquery-yui.html) 11:29:27 INFO - PROCESS | 7425 | RSS: Main: 216920064 11:29:27 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | Cycle 1(1): loaded http://localhost:35926/tests/dromaeo/cssquery-yui.html (next: http://localhost:35926/tests/dromaeo/cssquery-dojo.html) 11:32:30 INFO - PROCESS | 7425 | RSS: Main: 264916992 11:32:30 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | __start_tp_report 11:32:30 INFO - PROCESS | 7425 | _x_x_mozilla_page_load 11:32:30 INFO - PROCESS | 7425 | _x_x_mozilla_page_load_details 11:32:30 INFO - PROCESS | 7425 | |i|pagename|runs| 11:32:30 INFO - PROCESS | 7425 | |0;dojo.html;3140.2620384209713;3168.8890888818883;3175.523671449282;3205.471097268951;3230.5315729219265;5364.7317634118235;5380.677159370441;5396.757145928433;5466.426025267344;5515.283013208283;5315.441878602739;5330.3603567571845;5332.173513105465;5420.945790542093;5444.047291723942;4779.569838714515;4921.384826896638;4938;4957.479464656195;5124.743762811863;5009.949900500985;5055.9241611375855;5074.771635276403;5088.135017047092;5091.465396133408;4813.446453657822;4861.270809378586;4865.732384718839;4902.754862256873;4938.209886418156;4879.634027447955;4886.60907127429;4893.779779909877;4955.008998200338;4987.202047672391;4864.075825593126;4867.732274724889;4868.513148685139;4880;4915.311856340115;5154.278401023859;5257.894842103136;5366.838994830161;5432.2123292122815;5446.754896029688;5898.793542226044;5917.704114794243;5930.140129681172;5947.970260148715;5948.078047902582;5590.049691552445;5917.615355001911;5926.436988486087;5989.610675306091;5989.730462129215;5405.18922161675;5457.536109430703;5464.016477034133;5539.639923405047;5554.389017208145;6040.911097991169;6043.841232251036;6072.119542666377;6086.908696369558;6089.939100608937;5604.551635869121;5627.043402621564;5778.566607504454;5816.621919575214;5829.562782791308;5748.223989761413;5768.048272035067;5814.215080964101;5865.120231965239;5876.794312199138;5662.971685141631;5701.087825947829;5707.800226992035;5714.028615135437;5716.314042314949;5632.183333416631;5677.716114194356;5724.398938111438;5795.507381872504;5796;4327.112941846914;4332.566743325705;4333.43665323506;4367.27939889921;4370.628496577827;3848.960780589225;3868.458415821787;3871;3894;3900.5904380040256;5391.002664507078;5423.891522169613;5456.181572764117;5542.972285138549;5589.133684278943;5923;5939.13882487037;5947.078202878561;5983.940160598426;6007.849803754941;5637.408072152447;5647.49172574462;5648.4633959773755;5653.802116925888;5654.123610840326;4862.732549709729;4908.410990681141;4950.603951683856;4966.503349665077;5049.84850454487;6070.362611925772;6080.969595151996;6086.269647642312;6087.66517841523;6095.969520152371;5839.591228613956;5840.269966254218;5843.29880414353;5849.94150058511;5852.4147585241135;5941.732622031933;6002.159697642421;6008.24896887889;6009.759609615567;6054.243219597551;5707.514861236676;5714.9142762857755;5714.942850571441;5746.770129194785;5765.913511297418;5652.915206271991;5863.970680146572;5866.325372582208;5869.119632055226;5902.2327097477055;5600.131979543177;5612;5634.887302254014;5723.713814309352;5724.427557244242;5657.066584013592;5724.198612194213;5726.026575482095;5731.254936858182;5739.713014349182;5367.1680889462195;5506.834794956158;5617.101263797773;5633.0987042073075;5642.322921249476;5634.690092044977;5787.710614469344;5796.21751063601;5805.65166090019;5806.709664516673;5572.442755724395;5578.972105139448;5593;5609.354924183771;5627.409122042291 11:32:30 INFO - PROCESS | 7425 | |1;ext.html;589.4105894105894;610.2585358789071;613.4785432382474;626.8589567347346;633.2622494793566;33250.83374583127;43782.34326485101;44498.77750611251;44528.55471445285;44586;42566.787166064205;42987.355189672104;43027.569724302746;43048.78475607625;43053.784731076375;8094.3119834813815;8749.518776467292;8939.240164586017;10366.844497332546;10640.680779576625;10459.267851250415;10597.947010264937;10608.681739547827;10609.73475663107;10619.150467962545;10589.205809564275;10677.199210059238;10677.25259231854;10712.25014249003;10714.250002499828;7986.560739159344;10423.895761042406;10712.946435267773;10735.62425315118;11089.611863584816;10469.947650261776;10530.526126324334;10541.104006159485;10553.102986246178;10555.525001374957;40897.386539201936;41311.58688413107;41311.58688413107;41511.37732934008;41604.58395416037;3698.223373091654;3803.581606023335;3917;4152.6055024772595;4269.2044880618705;32944;33270.83364583162;33553;33632.15919602029;34762.82618586916;4116.115035267402;4190.874273771792;4313.245182093121;4365.585269399402;4385.495667998189;349834;351399;351527;352209;353369;61672;61864.69067654633;62155.378446215866;62201;62434;64476.35523644704;64985.67507162434;65052.67473662602;65107;65126.67436662786;16354.591135221715;16372.672546549002;16460;16518.83481165197;16528.09095499735;13063.281519516519;13122.081454298108;13142.145760525535;13153.408096635674;13153.868461315456;18221.202729054192;18996.62006759857;19070.42788716341;19145;19270.61458770817;5315.73421328932;6215.81352559424;6383.329750376237;6433.871322573522;6628.933710662928;996.2378780233128;1107.8227483602745;1125.1224045244721;1137.7383201863618;1184.727512672073;32534.83732581322;32548.511772323433;33151.66848331534;33230.50154247688;33591.83204083964;1109.7392112853472;1127.1039523578775;1130.383940752292;1132.1226049811462;1173.2256710571153;16923.91538042302;17356.3057477702;17402.825971740374;17456.94503461889;17484.91257543704;501273;503035;506247;506601;508076;57094.28717138492;57861.710691447115;57876.421235787944;57991.710041450366;58219.417805822246;1264.7849865522883;1352.75650382932;1358.456617353047;1362.1010133311966;1396.7834985577251;31669.36661266808;33837.830810845786;34159.14602134967;34629.00338173881;34717.65282347144;51333.379995800555;51644.22533662073;51965.48034519606;52050.73974630103;52120.73939630278;375645;378356;379890;380561;381302;37315.06712332214;41973.370399443425;42942.78528607337;43146.35280470733;45988.310175348066;48838;48995;49406.75296623494;50058.74970625269;50074.74962625309;40079.39880901847;41284.58715412807;41469.170616588104;41984.37023444712;42142.789286053376;40475.797621011705;40995.18009639731;41125;41294.58705413028;41669.374959375025;40646;41407.585924140374;41557.37663934983;42168;42650.78674606607;34574;37477.81261093677;37624;38226.235475290894;38244.61755382411;28706.56940145858;29054.85472572708;29281;29332.413351733274;29479.85260073772 11:32:30 INFO - PROCESS | 7425 | |2;jquery.html;368.85983326336003;381.7346943874008;387.50012483895773;391.11217536192845;408.2997659014789;17733.290668373265;19451.124699388525;19647.115879785408;19652.312169074085;19687.507812304662;18465.815341846577;18824.24703011878;19029.71455428166;19230.326938557155;19500.122494487747;5690.857728556788;5703.714814259291;5825.912611310834;5899.469047785698;5904.527637788988;5675.602707810455;5747.885042299152;5760.164776107462;5775.740091695884;5813.912791308113;5680.375158732536;5753.367129615739;5763.769449222026;5774.624649397776;5785.045467497858;5664.150377443375;5709.05800542912;5754.798582049608;5770.826875193751;5781.53747700183;5024.145895197825;5161.509656582619;5170.663906846081;5171.22431635254;5185.61107916904;22599.887000565057;22666.320010399715;22887.42781430461;22899.88550057239;23050.077996880103;2286.47411095449;2330.6387509935817;2828.61813655156;2964.5997790298247;3026.273694313349;13483.797743033861;13709.794353084711;13893.79159312611;14241.287935603283;14423.927880360636;1914.3873960332699;1920.5774729559475;1920.8559358048062;1929.1029671202818;1976.6046790641929;78812.60593697052;78846;79376;81424;81885.59057204676;10219.437930913871;10372.636957706594;10506.422146781848;10648.680539583826;10896.564137434414;14737.11577305365;14820.407183712747;14826;14835;14883.776743348859;8129.9187008129165;8310.127436619188;8432.367572432093;8536.359773016924;8582.914170858212;8266.669333226724;8324.70863519774;8396.412251142483;8455.704050358208;8559.914400856036;6547.937399719073;6559.409653131241;6633.767818126343;6663.666816659148;6672.432843208285;1805.268866109228;1896.7344571759966;1903.9238430462626;1908.885466871992;1924.0860591219339;1070.1920050361928;1070.4594179939236;1073.6778966310233;1077.6012875236213;1131.8189089745601;18674.813251867577;19158.71261931072;19464.610707785763;19710.802891971183;19812.801871981384;1007.325092188221;1012.2711647613706;1020.2450186861669;1025.3489034463169;1083.6911480228098;10648.254622176528;11318.207725459139;11339.716507087223;11343.489542970587;11376.203665743484;446051;451395;455754;456914;462366;82729;85918.57040714756;86311;86500;86794;993.7826162950472;1015.329882277708;1026.2764750850633;1032.256775121911;1037.7146284771597;17149.828501714823;17278.343563757644;17461.47615571535;17478.12609369501;17515.474535763948;32072.6792732079;38131.61868381392;38684.61315386923;38911;39279.821605351885;49776;59137.70431147817;59473.405265946785;59523.40476595352;60001.39998599958;8242.29940455068;8532.914670853212;8643.91356086431;8734.737957861274;8925.776855578662;9221.86167207479;12324.815127772912;13003.349832508526;13075.32895558171;13616.93191534036;11962.342071186169;12234;12238.388080595756;12262.08034397406;12297.93851030775;11749.47127379253;12114.75770484603;12131.939340303596;12197.75604487923;12299.200551964093;12092.576759813364;12134.878651213376;12387.504499819906;12516.812247816108;12592.433340499516;8443.324534037385;8452.197041281068;8548.487090774574;8759.737207883774;8906.955465222632;11067.632198383939;11461.140414469115;11759.47082381312;11849.289042657469;11865.288082715064 11:32:30 INFO - PROCESS | 7425 | |3;mootools.html;1377.6073818961597;1453.6729235921916;1488.903221290616;1615.1762601073456;1785.535760702217;8541.957290213548;8905.465672059681;8926.330525210611;9155.450672959627;9172.54137293136;8887.422317549355;9053.139951704594;9071.72784816455;9078.455292682444;9088.77278068047;2091.7176181215495;2319.1766922742436;2367.95264094718;2400.291913885408;2407.4944261705064;2371.395294199985;2431.57447446697;2431.6230984197477;2438.061346381647;2438.6585877977095;2339.63735620979;2344.78896899279;2380.9166679166233;2385.3321070100315;2386.5823480890776;2003.5892642008353;2194.967075493869;2252.662100684894;2259.1641092795608;2362.681038059857;2287.1308902617066;2316.2356422380576;2345.859248445082;2346.0733010460945;2346.6597343385115;8854.380193386402;8972.8654070189;9010.86483702745;9013.459192448474;9016.233620142295;5320.095583750772;5448.182772584105;5451.400345961941;5458.863528411782;5465.808696695636;3249.69127932846;3378.527006219131;3380.6619338066243;3405.165734395064;3453.0504111369323;1011.5245834457793;1013.6198925402974;1023.3808545829814;1036.3626369782605;1038.5897570459701;12698.174618649758;12813.615591532176;12921.160124591872;12946.093773435769;12946.417411216518;4552.726836389827;4635.188841952645;4738.010035784979;4754.358161648202;4811.518848115161;10961.506732197071;10986.121110311316;10986.615468458725;10989.175811814146;10993.065589424989;5396.514313711785;5410.188471729272;5410.91883621746;5411;5420.105682562412;4421.248387774086;4852.2479015752615;5000.874978125576;5001.649884508122;5009.874753131201;4050.144648023146;4075.1034772350035;4119.938200926988;4134.069834287321;4175.185838761412;1245.582729785514;1250.6685728282011;1265.5760320292804;1273.2615083251692;1277.8466584009977;883.5096521430668;969.0067680627413;1022.7238645565656;1045.0855501436242;1049.4228174503992;6001.609895356788;6182.207159923571;6203.503719702413;6240.594361366497;6432.421082102634;442.84500424851046;455.97036192648034;462.2373084410682;471.8042012564747;471.86080106368706;4220.915581688349;4240.088380998101;4258.276093064124;4269.423627810268;4294.141171765659;10989.835152472719;11362.545498180145;11366.261193022427;11412.657620271406;11427.771444571063;11291.266067705574;11306.886931130583;11308.151888608387;11313.094952403788;11318.660440186808;7990.161033091558;8252.05101413345;8272.131426200283;8415.873761893576;8454.182350794608;5989.910151347821;6385.10608514799;6411.954321697343;6414.198225221848;6427.839304017437;9894.307398482037;10308.690739277834;10347.793044139225;10450.68647940563;10563.154947604327;10339.896601034194;10534.52594633228;10558.683239502827;10682.89317106819;10703.411312377893;7001.614911179934;7596.278353556403;7840.255175758294;7870.819377093482;7980.760577182694;8819.867701984347;8835.514046727492;8865.157810008039;8901.376903616943;8913.064128266438;7550.8867366990635;7681.615919203906;7805;7868.449208555347;7949.125596184531;7455.440841936768;7729.884051739116;7809.492382995314;7870.488418252795;7886.68453261886;6934.479914006369;6985.965070174617;7001;7001.964990175016;7013.719451222098;4736.8578942631775;4839.249916262985;4927.630427718007;4965.155923492943;4981.427135879276;5267.3152490176035;5270.657407268515;5344.893102138013;5354.464553544614;5386.973065134649 11:32:30 INFO - PROCESS | 7425 | |4;prototype.html;325.85010894988307;333.3666034534384;338.53282470191135;338.9406853800584;339.82668838892175;5348.973255133724;5398.48714372135;5404.513758716355;5409.891802163955;5431.945680543194;5258.92111618326;5297.523222909937;5313.9734301328535;5337.359516857982;5338.786448542053;3973.9205215895663;4045.554988951213;4165.687573431989;4201.432806571104;4204.32730763078;4092.4679791627195;4149.232392007473;4168.874933751992;4171.791410429481;4190.811413486401;4143.171365726852;4146.253674338618;4147.9585204148025;4150.43969064177;4169.082801783603;3936.7047471439614;3957;4108.239975604522;4111.403846442279;4121.722266097519;3660.158163622382;3677.632236776301;3679.7608155469807;3681.5950245472977;3682.2635472905527;5049.64652474327;5053.357658760918;5058.1927030498055;5062.645614806965;5070.7464626768515;4367.432233809616;4667.393238878958;4669.6497762667595;4684;4685.390899183119;5451.454854514556;5457.945420545783;5464.535514481274;5468.316460442445;5487;3943.98028009861;3955.694620775166;3956.2285354355913;3983.880483585468;3990.900227494336;5448.210009548633;5615.9157612635845;5677.17680936262;5718.48533631971;5803.854903627401;4024;4029.6776257899296;4040.4343391925154;4044.292248856438;4067.1255680028935;4081.4490043844294;4093.406456063854;4093.4269202311702;4095.815688294034;4099.098198396348;4546.181687296318;4623.791929363187;4669.322948172564;4674.766261686902;4740.502247264057;5514.420985796514;5518;5531.2809334787025;5605.159226116115;5618.578606604521;1402.4039783092146;1414.653409914557;1419.5315545870044;1420.9342992755433;1425.3585886351184;883.3448021746881;898.8292224477328;908.6274627402734;925.0703043441298;939.5396255834592;5350.705711185922;5353.143497040533;5378.327709036371;5389.622726409114;5405;5597.63615365;5598.272224610774;5625.859353516113;5630.718464076862;5644.209810626516;5058.974705126451;5313.57491400687;5332.760025798849;5338.652987555796;5349;3003.7684549334667;3005.1435340927733;3014.8694239660126;3024.4253591817483;3028.1369809604157;5864.970675146682;5887.381824908323;5904.1734157218025;5911.226632010465;5921.881562368729;5521.00621888056;5755.381301507804;5791.710414479259;5839.328477225088;5853.824385268449;5996.730147143389;6004.189434426384;6006.699665016732;6010.016694490808;6017.338092809788;5474.616776825584;5737.340205876378;5741.741621626953;5754.741036653444;5799.884002320015;5614.943850561442;5656.321241451053;5658.971705141613;5675.836453527099;5678.261825962763;5971.701414929149;6008.969955150196;6009.278886533644;6015.6691381974415;6020.337762845996;3803.782789507442;3993.960060399359;4002.9599704002585;4006.4991876015497;4018.1160144768105;5651.095824668033;5684.545236381162;5690.260266165372;5721.771129154954;5724.971375143097;5301.867453313698;5540;5553.278073850373;5576.358718747396;5577.6295074593945;5506.724663766876;5522.420145884785;5530.529904957963;5538.529225015919;5547.833564993057;5260.263563101245;5401.514583489572;5435.967166238402;5441.455854414527;5454.2091396746455;5442.238086667949;5564.888702225851;5602;5609.242752228397;5612;5426.918596220981;5439.673619582838;5452.372977107683;5485.177223416519;5492.313460817398 11:32:30 INFO - PROCESS | 7425 | |5;yui.html;801.8797180422936;834.6953362022862;840.7898025493627;848.465466755944;852.7100785732849;13072.281024543647;13203.801942970838;13217.867821321785;13229.140105893135;13468.124571902832;13485.797713034288;13501;13534.187948723058;13535.91712662987;13541.255230962293;671.9496037797161;778.3695206882416;794.0986979777965;796.2753893956501;799.848028874512;774.0324594257179;778.1284960843834;780.1379475679378;780.2041917244408;781.0432220529834;847.6905929335779;848.1306660672828;848.2365870716343;848.9363297752662;849.9787505312355;709.2588245283665;835.1356346181703;844.6410275632832;846.1792061700172;847.7117779954845;622.6450922973906;623.323693792236;623.5697368815503;624.0296339192554;624.4036944717784;12739.108262421634;12745;12751.74496510074;12782.10525263232;12797.104202705814;12953.935230323883;13282.203067815866;13324.200547967055;13459.528916487876;13598.11612245201;11642.301461912228;11743.249101790501;11849.637291711391;11901;12278.324692141929;4321.569171881041;4350.912981740347;4401.889952751175;4424.40270563473;4477.70894891831;55761;55979.440205598235;56536.71731641357;58624.41375586232;59011.704941475444;10675.25273230882;10795.730106747395;10845.13238940883;11023.669289921316;11024.779504410028;18267.903925764498;18277.54306142357;18313.450596482126;18321.267149314146;18400;8002.759917202493;8167.754967350989;8222.054463736627;8437.704680336159;8463.111373305837;4661.207594708908;4721.386219791405;4723.102610504062;4807;4952.678075925125;3402.217489977319;3516.6307537708685;3524.4360902255517;3526.1713497328105;3526.8765593204116;590.2150140313373;650.9674516274167;657.1030543308445;660.8083655739878;696.022088965005;667.6428110960612;677.5460441504204;700.425650966213;747.4543583184305;779.9103103143211;8985.820283594292;9879.703608891745;10024.79950400988;10146.644867429604;10384.37693738378;585.906254999198;612.5589575505629;731.2212493694199;733.6698485681464;744.5681504727245;4782.689125206851;4791.377120974251;4805.6155507559315;4818.518148185153;4835.734034628059;75266.62366688241;75504.62247688726;76458;76557.6172119147;77010.22989770143;52333;64765;65409;65457.67271163709;68586.31413685899;54377.1843422349;57183;57371.713141434026;57622.135667964176;58188.70905645445;9625;9702.466364350028;9758.365706229073;9779.462129582942;9972.125122794001;36842.447363290106;37370.25259494741;37482.250354993295;38242.426363605126;39304.606953930095;46853;48368.27447588359;48419.27371089366;48518.757406212746;49106;12530;12567.37163141821;12694.159346894834;12785;12829.20391145259;12610;13736.725265494435;14227.07524010936;14274.857251427353;14327.57017289483;12588.685282868002;12723.872761272269;12835.743285134058;13291.445383599028;13701.931490342484;8119.837603247784;12667;12866.935665321987;13160.210387376788;13777.104488208635;11970.102242332034;11988.400579970792;12242.693932651755;12448.25310481374;12497.751663768928;9942.906280309306;10176.135028522658;10273.640422585473;10382.844257335995;10405.375677459377;10331.431771252353;10434.478276086316;10546.736331591772;10554.419506927192;10560.260781745204 11:32:30 INFO - PROCESS | 7425 | __end_tp_report 11:32:30 INFO - PROCESS | 7425 | __start_cc_report 11:32:30 INFO - PROCESS | 7425 | _x_x_mozilla_cycle_collect,893 11:32:30 INFO - PROCESS | 7425 | __end_cc_report 11:32:30 INFO - PROCESS | 7425 | __startTimestamp1464114750467__endTimestamp 11:32:30 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | ------- Summary: start ------- 11:32:30 INFO - PROCESS | 7425 | Number of tests: 6 11:32:30 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | [#0] dojo.html Cycles:165 Average:5405.16 Median:5627.41 stddev:636.26 (11.3%) stddev-sans-first:612.90 11:32:30 INFO - PROCESS | 7425 | Values: 3140.3 3168.9 3175.5 3205.5 3230.5 5364.7 5380.7 5396.8 5466.4 5515.3 5315.4 5330.4 5332.2 5420.9 5444.0 4779.6 4921.4 4938.0 4957.5 5124.7 5009.9 5055.9 5074.8 5088.1 5091.5 4813.4 4861.3 4865.7 4902.8 4938.2 4879.6 4886.6 4893.8 4955.0 4987.2 4864.1 4867.7 4868.5 4880.0 4915.3 5154.3 5257.9 5366.8 5432.2 5446.8 5898.8 5917.7 5930.1 5948.0 5948.1 5590.0 5917.6 5926.4 5989.6 5989.7 5405.2 5457.5 5464.0 5539.6 5554.4 6040.9 6043.8 6072.1 6086.9 6089.9 5604.6 5627.0 5778.6 5816.6 5829.6 5748.2 5768.0 5814.2 5865.1 5876.8 5663.0 5701.1 5707.8 5714.0 5716.3 5632.2 5677.7 5724.4 5795.5 5796.0 4327.1 4332.6 4333.4 4367.3 4370.6 3849.0 3868.5 3871.0 3894.0 3900.6 5391.0 5423.9 5456.2 5543.0 5589.1 5923.0 5939.1 5947.1 5983.9 6007.8 5637.4 5647.5 5648.5 5653.8 5654.1 4862.7 4908.4 4950.6 4966.5 5049.8 6070.4 6081.0 6086.3 6087.7 6096.0 5839.6 5840.3 5843.3 5849.9 5852.4 5941.7 6002.2 6008.2 6009.8 6054.2 5707.5 5714.9 5714.9 5746.8 5765.9 5652.9 5864.0 5866.3 5869.1 5902.2 5600.1 5612.0 5634.9 5723.7 5724.4 5657.1 5724.2 5726.0 5731.3 5739.7 5367.2 5506.8 5617.1 5633.1 5642.3 5634.7 5787.7 5796.2 5805.7 5806.7 5572.4 5579.0 5593.0 5609.4 5627.4 11:32:30 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | [#1] ext.html Cycles:180 Average:58819.57 Median:380931.50 stddev:110117.01 (28.9%) stddev-sans-first:110339.13 11:32:30 INFO - PROCESS | 7425 | Values: 589.4 610.3 613.5 626.9 633.3 33250.8 43782.3 44498.8 44528.6 44586.0 42566.8 42987.4 43027.6 43048.8 43053.8 8094.3 8749.5 8939.2 10366.8 10640.7 10459.3 10597.9 10608.7 10609.7 10619.2 10589.2 10677.2 10677.3 10712.3 10714.3 7986.6 10423.9 10712.9 10735.6 11089.6 10469.9 10530.5 10541.1 10553.1 10555.5 40897.4 41311.6 41311.6 41511.4 41604.6 3698.2 3803.6 3917.0 4152.6 4269.2 32944.0 33270.8 33553.0 33632.2 34762.8 4116.1 4190.9 4313.2 4365.6 4385.5 349834.0 351399.0 351527.0 352209.0 353369.0 61672.0 61864.7 62155.4 62201.0 62434.0 64476.4 64985.7 65052.7 65107.0 65126.7 16354.6 16372.7 16460.0 16518.8 16528.1 13063.3 13122.1 13142.1 13153.4 13153.9 18221.2 18996.6 19070.4 19145.0 19270.6 5315.7 6215.8 6383.3 6433.9 6628.9 996.2 1107.8 1125.1 1137.7 1184.7 32534.8 32548.5 33151.7 33230.5 33591.8 1109.7 1127.1 1130.4 1132.1 1173.2 16923.9 17356.3 17402.8 17456.9 17484.9 501273.0 503035.0 506247.0 506601.0 508076.0 57094.3 57861.7 57876.4 57991.7 58219.4 1264.8 1352.8 1358.5 1362.1 1396.8 31669.4 33837.8 34159.1 34629.0 34717.7 51333.4 51644.2 51965.5 52050.7 52120.7 375645.0 378356.0 379890.0 380561.0 381302.0 37315.1 41973.4 42942.8 43146.4 45988.3 48838.0 48995.0 49406.8 50058.7 50074.7 40079.4 41284.6 41469.2 41984.4 42142.8 40475.8 40995.2 41125.0 41294.6 41669.4 40646.0 41407.6 41557.4 42168.0 42650.8 34574.0 37477.8 37624.0 38226.2 38244.6 28706.6 29054.9 29281.0 29332.4 29479.9 11:32:30 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | [#2] jquery.html Cycles:180 Average:27858.02 Median:12586.95 stddev:74925.29 (595.3%) stddev-sans-first:75107.05 11:32:30 INFO - PROCESS | 7425 | Values: 368.9 381.7 387.5 391.1 408.3 17733.3 19451.1 19647.1 19652.3 19687.5 18465.8 18824.2 19029.7 19230.3 19500.1 5690.9 5703.7 5825.9 5899.5 5904.5 5675.6 5747.9 5760.2 5775.7 5813.9 5680.4 5753.4 5763.8 5774.6 5785.0 5664.2 5709.1 5754.8 5770.8 5781.5 5024.1 5161.5 5170.7 5171.2 5185.6 22599.9 22666.3 22887.4 22899.9 23050.1 2286.5 2330.6 2828.6 2964.6 3026.3 13483.8 13709.8 13893.8 14241.3 14423.9 1914.4 1920.6 1920.9 1929.1 1976.6 78812.6 78846.0 79376.0 81424.0 81885.6 10219.4 10372.6 10506.4 10648.7 10896.6 14737.1 14820.4 14826.0 14835.0 14883.8 8129.9 8310.1 8432.4 8536.4 8582.9 8266.7 8324.7 8396.4 8455.7 8559.9 6547.9 6559.4 6633.8 6663.7 6672.4 1805.3 1896.7 1903.9 1908.9 1924.1 1070.2 1070.5 1073.7 1077.6 1131.8 18674.8 19158.7 19464.6 19710.8 19812.8 1007.3 1012.3 1020.2 1025.3 1083.7 10648.3 11318.2 11339.7 11343.5 11376.2 446051.0 451395.0 455754.0 456914.0 462366.0 82729.0 85918.6 86311.0 86500.0 86794.0 993.8 1015.3 1026.3 1032.3 1037.7 17149.8 17278.3 17461.5 17478.1 17515.5 32072.7 38131.6 38684.6 38911.0 39279.8 49776.0 59137.7 59473.4 59523.4 60001.4 8242.3 8532.9 8643.9 8734.7 8925.8 9221.9 12324.8 13003.3 13075.3 13616.9 11962.3 12234.0 12238.4 12262.1 12297.9 11749.5 12114.8 12131.9 12197.8 12299.2 12092.6 12134.9 12387.5 12516.8 12592.4 8443.3 8452.2 8548.5 8759.7 8907.0 11067.6 11461.1 11759.5 11849.3 11865.3 11:32:30 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | [#3] mootools.html Cycles:180 Average:5928.59 Median:2507.48 stddev:3455.03 (137.8%) stddev-sans-first:3447.80 11:32:30 INFO - PROCESS | 7425 | Values: 1377.6 1453.7 1488.9 1615.2 1785.5 8542.0 8905.5 8926.3 9155.5 9172.5 8887.4 9053.1 9071.7 9078.5 9088.8 2091.7 2319.2 2368.0 2400.3 2407.5 2371.4 2431.6 2431.6 2438.1 2438.7 2339.6 2344.8 2380.9 2385.3 2386.6 2003.6 2195.0 2252.7 2259.2 2362.7 2287.1 2316.2 2345.9 2346.1 2346.7 8854.4 8972.9 9010.9 9013.5 9016.2 5320.1 5448.2 5451.4 5458.9 5465.8 3249.7 3378.5 3380.7 3405.2 3453.1 1011.5 1013.6 1023.4 1036.4 1038.6 12698.2 12813.6 12921.2 12946.1 12946.4 4552.7 4635.2 4738.0 4754.4 4811.5 10961.5 10986.1 10986.6 10989.2 10993.1 5396.5 5410.2 5410.9 5411.0 5420.1 4421.2 4852.2 5000.9 5001.6 5009.9 4050.1 4075.1 4119.9 4134.1 4175.2 1245.6 1250.7 1265.6 1273.3 1277.8 883.5 969.0 1022.7 1045.1 1049.4 6001.6 6182.2 6203.5 6240.6 6432.4 442.8 456.0 462.2 471.8 471.9 4220.9 4240.1 4258.3 4269.4 4294.1 10989.8 11362.5 11366.3 11412.7 11427.8 11291.3 11306.9 11308.2 11313.1 11318.7 7990.2 8252.1 8272.1 8415.9 8454.2 5989.9 6385.1 6412.0 6414.2 6427.8 9894.3 10308.7 10347.8 10450.7 10563.2 10339.9 10534.5 10558.7 10682.9 10703.4 7001.6 7596.3 7840.3 7870.8 7980.8 8819.9 8835.5 8865.2 8901.4 8913.1 7550.9 7681.6 7805.0 7868.4 7949.1 7455.4 7729.9 7809.5 7870.5 7886.7 6934.5 6986.0 7001.0 7002.0 7013.7 4736.9 4839.2 4927.6 4965.2 4981.4 5267.3 5270.7 5344.9 5354.5 5387.0 11:32:30 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | [#4] prototype.html Cycles:180 Average:4668.09 Median:5383.98 stddev:1381.15 (25.7%) stddev-sans-first:1346.03 11:32:30 INFO - PROCESS | 7425 | Values: 325.9 333.4 338.5 338.9 339.8 5349.0 5398.5 5404.5 5409.9 5431.9 5258.9 5297.5 5314.0 5337.4 5338.8 3973.9 4045.6 4165.7 4201.4 4204.3 4092.5 4149.2 4168.9 4171.8 4190.8 4143.2 4146.3 4148.0 4150.4 4169.1 3936.7 3957.0 4108.2 4111.4 4121.7 3660.2 3677.6 3679.8 3681.6 3682.3 5049.6 5053.4 5058.2 5062.6 5070.7 4367.4 4667.4 4669.6 4684.0 4685.4 5451.5 5457.9 5464.5 5468.3 5487.0 3944.0 3955.7 3956.2 3983.9 3990.9 5448.2 5615.9 5677.2 5718.5 5803.9 4024.0 4029.7 4040.4 4044.3 4067.1 4081.4 4093.4 4093.4 4095.8 4099.1 4546.2 4623.8 4669.3 4674.8 4740.5 5514.4 5518.0 5531.3 5605.2 5618.6 1402.4 1414.7 1419.5 1420.9 1425.4 883.3 898.8 908.6 925.1 939.5 5350.7 5353.1 5378.3 5389.6 5405.0 5597.6 5598.3 5625.9 5630.7 5644.2 5059.0 5313.6 5332.8 5338.7 5349.0 3003.8 3005.1 3014.9 3024.4 3028.1 5865.0 5887.4 5904.2 5911.2 5921.9 5521.0 5755.4 5791.7 5839.3 5853.8 5996.7 6004.2 6006.7 6010.0 6017.3 5474.6 5737.3 5741.7 5754.7 5799.9 5614.9 5656.3 5659.0 5675.8 5678.3 5971.7 6009.0 6009.3 6015.7 6020.3 3803.8 3994.0 4003.0 4006.5 4018.1 5651.1 5684.5 5690.3 5721.8 5725.0 5301.9 5540.0 5553.3 5576.4 5577.6 5506.7 5522.4 5530.5 5538.5 5547.8 5260.3 5401.5 5436.0 5441.5 5454.2 5442.2 5564.9 5602.0 5609.2 5612.0 5426.9 5439.7 5452.4 5485.2 5492.3 11:32:30 INFO - PROCESS | 7425 | 11:32:30 INFO - PROCESS | 7425 | [#5] yui.html Cycles:180 Average:15842.67 Median:4787.03 stddev:19604.63 (409.5%) stddev-sans-first:19627.09 11:32:30 INFO - PROCESS | 7425 | Values: 801.9 834.7 840.8 848.5 852.7 13072.3 13203.8 13217.9 13229.1 13468.1 13485.8 13501.0 13534.2 13535.9 13541.3 671.9 778.4 794.1 796.3 799.8 774.0 778.1 780.1 780.2 781.0 847.7 848.1 848.2 848.9 850.0 709.3 835.1 844.6 846.2 847.7 622.6 623.3 623.6 624.0 624.4 12739.1 12745.0 12751.7 12782.1 12797.1 12953.9 13282.2 13324.2 13459.5 13598.1 11642.3 11743.2 11849.6 11901.0 12278.3 4321.6 4350.9 4401.9 4424.4 4477.7 55761.0 55979.4 56536.7 58624.4 59011.7 10675.3 10795.7 10845.1 11023.7 11024.8 18267.9 18277.5 18313.5 18321.3 18400.0 8002.8 8167.8 8222.1 8437.7 8463.1 4661.2 4721.4 4723.1 4807.0 4952.7 3402.2 3516.6 3524.4 3526.2 3526.9 590.2 651.0 657.1 660.8 696.0 667.6 677.5 700.4 747.5 779.9 8985.8 9879.7 10024.8 10146.6 10384.4 585.9 612.6 731.2 733.7 744.6 4782.7 4791.4 4805.6 4818.5 4835.7 75266.6 75504.6 76458.0 76557.6 77010.2 52333.0 64765.0 65409.0 65457.7 68586.3 54377.2 57183.0 57371.7 57622.1 58188.7 9625.0 9702.5 9758.4 9779.5 9972.1 36842.4 37370.3 37482.3 38242.4 39304.6 46853.0 48368.3 48419.3 48518.8 49106.0 12530.0 12567.4 12694.2 12785.0 12829.2 12610.0 13736.7 14227.1 14274.9 14327.6 12588.7 12723.9 12835.7 13291.4 13701.9 8119.8 12667.0 12866.9 13160.2 13777.1 11970.1 11988.4 12242.7 12448.3 12497.8 9942.9 10176.1 10273.6 10382.8 10405.4 10331.4 10434.5 10546.7 10554.4 10560.3 11:32:30 INFO - PROCESS | 7425 | -------- Summary: end -------- 11:32:30 INFO - PROCESS | 7425 | 11:32:31 INFO - TEST-INFO | 7425: exit 0 11:32:31 INFO - TEST-OK | dromaeo_css | took 1111755ms 11:32:31 INFO - TEST-START | kraken 11:32:31 INFO - operating with platform_type : linux_ 11:32:31 INFO - Initialising browser for kraken test... 11:32:31 INFO - TEST-INFO | started process 7614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYyL7R/profile http://localhost:35926/getInfo.html) 11:32:34 INFO - PROCESS | 7614 | __metrics Screen width/height:1600/1200 11:32:34 INFO - PROCESS | 7614 | colorDepth:24 11:32:34 INFO - PROCESS | 7614 | Browser inner width/height: 1024/697 11:32:34 INFO - PROCESS | 7614 | __metrics 11:32:35 ERROR - PROCESS | 7614 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:32:36 INFO - TEST-INFO | 7614: exit 0 11:32:36 INFO - Browser initialized. 11:32:36 INFO - Running cycle 1/1 for kraken test... 11:32:36 INFO - TEST-INFO | started process 7694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYyL7R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:48 INFO - PROCESS | 7694 | RSS: Main: 153235456 11:32:48 INFO - PROCESS | 7694 | 11:32:50 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35926/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:51 INFO - PROCESS | 7694 | RSS: Main: 209522688 11:32:51 INFO - PROCESS | 7694 | 11:32:54 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35926/tests/kraken/driver.html?testName=audio-dft) 11:32:54 INFO - PROCESS | 7694 | RSS: Main: 197595136 11:32:54 INFO - PROCESS | 7694 | 11:32:58 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35926/tests/kraken/driver.html?testName=audio-fft) 11:32:58 INFO - PROCESS | 7694 | RSS: Main: 265306112 11:32:58 INFO - PROCESS | 7694 | 11:33:00 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35926/tests/kraken/driver.html?testName=audio-oscillator) 11:33:01 INFO - PROCESS | 7694 | RSS: Main: 175222784 11:33:01 INFO - PROCESS | 7694 | 11:33:03 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35926/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:04 INFO - PROCESS | 7694 | RSS: Main: 179302400 11:33:04 INFO - PROCESS | 7694 | 11:33:07 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35926/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:07 INFO - PROCESS | 7694 | RSS: Main: 215171072 11:33:07 INFO - PROCESS | 7694 | 11:33:11 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35926/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:11 INFO - PROCESS | 7694 | RSS: Main: 216391680 11:33:11 INFO - PROCESS | 7694 | 11:33:14 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35926/tests/kraken/driver.html?testName=json-parse-financial) 11:33:15 INFO - PROCESS | 7694 | RSS: Main: 216141824 11:33:15 INFO - PROCESS | 7694 | 11:33:16 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35926/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:17 INFO - PROCESS | 7694 | RSS: Main: 202833920 11:33:17 INFO - PROCESS | 7694 | 11:33:19 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35926/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:19 INFO - PROCESS | 7694 | RSS: Main: 207101952 11:33:19 INFO - PROCESS | 7694 | 11:33:21 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35926/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:22 INFO - PROCESS | 7694 | RSS: Main: 217333760 11:33:22 INFO - PROCESS | 7694 | 11:33:25 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:25 INFO - PROCESS | 7694 | RSS: Main: 224120832 11:33:25 INFO - PROCESS | 7694 | 11:33:28 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:28 INFO - PROCESS | 7694 | RSS: Main: 222482432 11:33:28 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | Cycle 1(1): loaded http://localhost:35926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35926/tests/kraken/driver.html?testName=ai-astar) 11:33:30 INFO - PROCESS | 7694 | RSS: Main: 267718656 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | __start_tp_report 11:33:30 INFO - PROCESS | 7694 | _x_x_mozilla_page_load 11:33:30 INFO - PROCESS | 7694 | _x_x_mozilla_page_load_details 11:33:30 INFO - PROCESS | 7694 | |i|pagename|runs| 11:33:30 INFO - PROCESS | 7694 | |0;ai-astar;111;105;109;110;110;110;111;112;109;111 11:33:30 INFO - PROCESS | 7694 | |1;audio-beat-detection;152;123;132;188;130;127;158;123;179;124 11:33:30 INFO - PROCESS | 7694 | |2;audio-dft;161;160;162;160;162;161;161;162;160;162 11:33:30 INFO - PROCESS | 7694 | |3;audio-fft;74;76;74;119;74;76;74;75;103;75 11:33:30 INFO - PROCESS | 7694 | |4;audio-oscillator;83;82;129;83;83;84;127;84;84;118 11:33:30 INFO - PROCESS | 7694 | |5;imaging-gaussian-blur;117;117;116;117;116;118;118;118;117;117 11:33:30 INFO - PROCESS | 7694 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;145 11:33:30 INFO - PROCESS | 7694 | |7;imaging-desaturate;94;95;95;95;94;94;94;95;94;95 11:33:30 INFO - PROCESS | 7694 | |8;json-parse-financial;54;55;56;54;55;56;54;72;54;52 11:33:30 INFO - PROCESS | 7694 | |9;json-stringify-tinderbox;61;62;61;61;61;63;62;61;63;65 11:33:30 INFO - PROCESS | 7694 | |10;stanford-crypto-aes;79;85;82;79;86;83;81;80;87;81 11:33:30 INFO - PROCESS | 7694 | |11;stanford-crypto-ccm;122;118;120;129;126;119;129;126;176;130 11:33:30 INFO - PROCESS | 7694 | |12;stanford-crypto-pbkdf2;162;159;157;158;156;157;158;169;160;163 11:33:30 INFO - PROCESS | 7694 | |13;stanford-crypto-sha256-iterative;63;62;64;63;62;61;62;62;61;62 11:33:30 INFO - PROCESS | 7694 | __end_tp_report 11:33:30 INFO - PROCESS | 7694 | __start_cc_report 11:33:30 INFO - PROCESS | 7694 | _x_x_mozilla_cycle_collect,1613 11:33:30 INFO - PROCESS | 7694 | __end_cc_report 11:33:30 INFO - PROCESS | 7694 | __startTimestamp1464114810866__endTimestamp 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | ------- Summary: start ------- 11:33:30 INFO - PROCESS | 7694 | Number of tests: 14 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:1.93 (1.7%) stddev-sans-first:2.00 11:33:30 INFO - PROCESS | 7694 | Values: 111.0 105.0 109.0 110.0 110.0 110.0 111.0 112.0 109.0 111.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:142.00 stddev:24.34 (17.1%) stddev-sans-first:25.62 11:33:30 INFO - PROCESS | 7694 | Values: 152.0 123.0 132.0 188.0 130.0 127.0 158.0 123.0 179.0 124.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 11:33:30 INFO - PROCESS | 7694 | Values: 161.0 160.0 162.0 160.0 162.0 161.0 161.0 162.0 160.0 162.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.50 stddev:15.76 (21.2%) stddev-sans-first:16.45 11:33:30 INFO - PROCESS | 7694 | Values: 74.0 76.0 74.0 119.0 74.0 76.0 74.0 75.0 103.0 75.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:83.00 stddev:20.19 (24.3%) stddev-sans-first:20.88 11:33:30 INFO - PROCESS | 7694 | Values: 83.0 82.0 129.0 83.0 83.0 84.0 127.0 84.0 84.0 118.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 11:33:30 INFO - PROCESS | 7694 | Values: 117.0 117.0 116.0 117.0 116.0 118.0 118.0 118.0 117.0 117.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 11:33:30 INFO - PROCESS | 7694 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 11:33:30 INFO - PROCESS | 7694 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:5.67 (10.3%) stddev-sans-first:5.96 11:33:30 INFO - PROCESS | 7694 | Values: 54.0 55.0 56.0 54.0 55.0 56.0 54.0 72.0 54.0 52.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.33 (2.2%) stddev-sans-first:1.36 11:33:30 INFO - PROCESS | 7694 | Values: 61.0 62.0 61.0 61.0 61.0 63.0 62.0 61.0 63.0 65.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:2.87 (3.5%) stddev-sans-first:2.78 11:33:30 INFO - PROCESS | 7694 | Values: 79.0 85.0 82.0 79.0 86.0 83.0 81.0 80.0 87.0 81.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:127.50 stddev:16.92 (13.3%) stddev-sans-first:17.73 11:33:30 INFO - PROCESS | 7694 | Values: 122.0 118.0 120.0 129.0 126.0 119.0 129.0 126.0 176.0 130.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:159.50 stddev:3.90 (2.4%) stddev-sans-first:4.06 11:33:30 INFO - PROCESS | 7694 | Values: 162.0 159.0 157.0 158.0 156.0 157.0 158.0 169.0 160.0 163.0 11:33:30 INFO - PROCESS | 7694 | 11:33:30 INFO - PROCESS | 7694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 11:33:30 INFO - PROCESS | 7694 | Values: 63.0 62.0 64.0 63.0 62.0 61.0 62.0 62.0 61.0 62.0 11:33:30 INFO - PROCESS | 7694 | -------- Summary: end -------- 11:33:30 INFO - PROCESS | 7694 | 11:33:31 INFO - TEST-INFO | 7694: exit 0 11:33:31 INFO - TEST-OK | kraken | took 60708ms 11:33:31 INFO - SUITE-END | took 1172s 11:33:32 INFO - Completed test suite (00:19:32) 11:33:32 INFO - javascript benchmark 11:33:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.2620384209713, 3168.8890888818883, 3175.523671449282, 3205.471097268951, 3230.5315729219265, 5364.7317634118235, 5380.677159370441, 5396.757145928433, 5466.426025267344, 5515.283013208283, 5315.441878602739, 5330.3603567571845, 5332.173513105465, 5420.945790542093, 5444.047291723942, 4779.569838714515, 4921.384826896638, 4938.0, 4957.479464656195, 5124.743762811863, 5009.949900500985, 5055.9241611375855, 5074.771635276403, 5088.135017047092, 5091.465396133408, 4813.446453657822, 4861.270809378586, 4865.732384718839, 4902.754862256873, 4938.209886418156, 4879.634027447955, 4886.60907127429, 4893.779779909877, 4955.008998200338, 4987.202047672391, 4864.075825593126, 4867.732274724889, 4868.513148685139, 4880.0, 4915.311856340115, 5154.278401023859, 5257.894842103136, 5366.838994830161, 5432.2123292122815, 5446.754896029688, 5898.793542226044, 5917.704114794243, 5930.140129681172, 5947.970260148715, 5948.078047902582, 5590.049691552445, 5917.615355001911, 5926.436988486087, 5989.610675306091, 5989.730462129215, 5405.18922161675, 5457.536109430703, 5464.016477034133, 5539.639923405047, 5554.389017208145, 6040.911097991169, 6043.841232251036, 6072.119542666377, 6086.908696369558, 6089.939100608937, 5604.551635869121, 5627.043402621564, 5778.566607504454, 5816.621919575214, 5829.562782791308, 5748.223989761413, 5768.048272035067, 5814.215080964101, 5865.120231965239, 5876.794312199138, 5662.971685141631, 5701.087825947829, 5707.800226992035, 5714.028615135437, 5716.314042314949, 5632.183333416631, 5677.716114194356, 5724.398938111438, 5795.507381872504, 5796.0, 4327.112941846914, 4332.566743325705, 4333.43665323506, 4367.27939889921, 4370.628496577827, 3848.960780589225, 3868.458415821787, 3871.0, 3894.0, 3900.5904380040256, 5391.002664507078, 5423.891522169613, 5456.181572764117, 5542.972285138549, 5589.133684278943, 5923.0, 5939.13882487037, 5947.078202878561, 5983.940160598426, 6007.849803754941, 5637.408072152447, 5647.49172574462, 5648.4633959773755, 5653.802116925888, 5654.123610840326, 4862.732549709729, 4908.410990681141, 4950.603951683856, 4966.503349665077, 5049.84850454487, 6070.362611925772, 6080.969595151996, 6086.269647642312, 6087.66517841523, 6095.969520152371, 5839.591228613956, 5840.269966254218, 5843.29880414353, 5849.94150058511, 5852.4147585241135, 5941.732622031933, 6002.159697642421, 6008.24896887889, 6009.759609615567, 6054.243219597551, 5707.514861236676, 5714.9142762857755, 5714.942850571441, 5746.770129194785, 5765.913511297418, 5652.915206271991, 5863.970680146572, 5866.325372582208, 5869.119632055226, 5902.2327097477055, 5600.131979543177, 5612.0, 5634.887302254014, 5723.713814309352, 5724.427557244242, 5657.066584013592, 5724.198612194213, 5726.026575482095, 5731.254936858182, 5739.713014349182, 5367.1680889462195, 5506.834794956158, 5617.101263797773, 5633.0987042073075, 5642.322921249476, 5634.690092044977, 5787.710614469344, 5796.21751063601, 5805.65166090019, 5806.709664516673, 5572.442755724395, 5578.972105139448, 5593.0, 5609.354924183771, 5627.409122042291], "value": 5361.175922588495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.4105894105894, 610.2585358789071, 613.4785432382474, 626.8589567347346, 633.2622494793566, 33250.83374583127, 43782.34326485101, 44498.77750611251, 44528.55471445285, 44586.0, 42566.787166064205, 42987.355189672104, 43027.569724302746, 43048.78475607625, 43053.784731076375, 8094.3119834813815, 8749.518776467292, 8939.240164586017, 10366.844497332546, 10640.680779576625, 10459.267851250415, 10597.947010264937, 10608.681739547827, 10609.73475663107, 10619.150467962545, 10589.205809564275, 10677.199210059238, 10677.25259231854, 10712.25014249003, 10714.250002499828, 7986.560739159344, 10423.895761042406, 10712.946435267773, 10735.62425315118, 11089.611863584816, 10469.947650261776, 10530.526126324334, 10541.104006159485, 10553.102986246178, 10555.525001374957, 40897.386539201936, 41311.58688413107, 41311.58688413107, 41511.37732934008, 41604.58395416037, 3698.223373091654, 3803.581606023335, 3917.0, 4152.6055024772595, 4269.2044880618705, 32944.0, 33270.83364583162, 33553.0, 33632.15919602029, 34762.82618586916, 4116.115035267402, 4190.874273771792, 4313.245182093121, 4365.585269399402, 4385.495667998189, 349834.0, 351399.0, 351527.0, 352209.0, 353369.0, 61672.0, 61864.69067654633, 62155.378446215866, 62201.0, 62434.0, 64476.35523644704, 64985.67507162434, 65052.67473662602, 65107.0, 65126.67436662786, 16354.591135221715, 16372.672546549002, 16460.0, 16518.83481165197, 16528.09095499735, 13063.281519516519, 13122.081454298108, 13142.145760525535, 13153.408096635674, 13153.868461315456, 18221.202729054192, 18996.62006759857, 19070.42788716341, 19145.0, 19270.61458770817, 5315.73421328932, 6215.81352559424, 6383.329750376237, 6433.871322573522, 6628.933710662928, 996.2378780233128, 1107.8227483602745, 1125.1224045244721, 1137.7383201863618, 1184.727512672073, 32534.83732581322, 32548.511772323433, 33151.66848331534, 33230.50154247688, 33591.83204083964, 1109.7392112853472, 1127.1039523578775, 1130.383940752292, 1132.1226049811462, 1173.2256710571153, 16923.91538042302, 17356.3057477702, 17402.825971740374, 17456.94503461889, 17484.91257543704, 501273.0, 503035.0, 506247.0, 506601.0, 508076.0, 57094.28717138492, 57861.710691447115, 57876.421235787944, 57991.710041450366, 58219.417805822246, 1264.7849865522883, 1352.75650382932, 1358.456617353047, 1362.1010133311966, 1396.7834985577251, 31669.36661266808, 33837.830810845786, 34159.14602134967, 34629.00338173881, 34717.65282347144, 51333.379995800555, 51644.22533662073, 51965.48034519606, 52050.73974630103, 52120.73939630278, 375645.0, 378356.0, 379890.0, 380561.0, 381302.0, 37315.06712332214, 41973.370399443425, 42942.78528607337, 43146.35280470733, 45988.310175348066, 48838.0, 48995.0, 49406.75296623494, 50058.74970625269, 50074.74962625309, 40079.39880901847, 41284.58715412807, 41469.170616588104, 41984.37023444712, 42142.789286053376, 40475.797621011705, 40995.18009639731, 41125.0, 41294.58705413028, 41669.374959375025, 40646.0, 41407.585924140374, 41557.37663934983, 42168.0, 42650.78674606607, 34574.0, 37477.81261093677, 37624.0, 38226.235475290894, 38244.61755382411, 28706.56940145858, 29054.85472572708, 29281.0, 29332.413351733274, 29479.85260073772], "value": 20882.117910150457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.85983326336003, 381.7346943874008, 387.50012483895773, 391.11217536192845, 408.2997659014789, 17733.290668373265, 19451.124699388525, 19647.115879785408, 19652.312169074085, 19687.507812304662, 18465.815341846577, 18824.24703011878, 19029.71455428166, 19230.326938557155, 19500.122494487747, 5690.857728556788, 5703.714814259291, 5825.912611310834, 5899.469047785698, 5904.527637788988, 5675.602707810455, 5747.885042299152, 5760.164776107462, 5775.740091695884, 5813.912791308113, 5680.375158732536, 5753.367129615739, 5763.769449222026, 5774.624649397776, 5785.045467497858, 5664.150377443375, 5709.05800542912, 5754.798582049608, 5770.826875193751, 5781.53747700183, 5024.145895197825, 5161.509656582619, 5170.663906846081, 5171.22431635254, 5185.61107916904, 22599.887000565057, 22666.320010399715, 22887.42781430461, 22899.88550057239, 23050.077996880103, 2286.47411095449, 2330.6387509935817, 2828.61813655156, 2964.5997790298247, 3026.273694313349, 13483.797743033861, 13709.794353084711, 13893.79159312611, 14241.287935603283, 14423.927880360636, 1914.3873960332699, 1920.5774729559475, 1920.8559358048062, 1929.1029671202818, 1976.6046790641929, 78812.60593697052, 78846.0, 79376.0, 81424.0, 81885.59057204676, 10219.437930913871, 10372.636957706594, 10506.422146781848, 10648.680539583826, 10896.564137434414, 14737.11577305365, 14820.407183712747, 14826.0, 14835.0, 14883.776743348859, 8129.9187008129165, 8310.127436619188, 8432.367572432093, 8536.359773016924, 8582.914170858212, 8266.669333226724, 8324.70863519774, 8396.412251142483, 8455.704050358208, 8559.914400856036, 6547.937399719073, 6559.409653131241, 6633.767818126343, 6663.666816659148, 6672.432843208285, 1805.268866109228, 1896.7344571759966, 1903.9238430462626, 1908.885466871992, 1924.0860591219339, 1070.1920050361928, 1070.4594179939236, 1073.6778966310233, 1077.6012875236213, 1131.8189089745601, 18674.813251867577, 19158.71261931072, 19464.610707785763, 19710.802891971183, 19812.801871981384, 1007.325092188221, 1012.2711647613706, 1020.2450186861669, 1025.3489034463169, 1083.6911480228098, 10648.254622176528, 11318.207725459139, 11339.716507087223, 11343.489542970587, 11376.203665743484, 446051.0, 451395.0, 455754.0, 456914.0, 462366.0, 82729.0, 85918.57040714756, 86311.0, 86500.0, 86794.0, 993.7826162950472, 1015.329882277708, 1026.2764750850633, 1032.256775121911, 1037.7146284771597, 17149.828501714823, 17278.343563757644, 17461.47615571535, 17478.12609369501, 17515.474535763948, 32072.6792732079, 38131.61868381392, 38684.61315386923, 38911.0, 39279.821605351885, 49776.0, 59137.70431147817, 59473.405265946785, 59523.40476595352, 60001.39998599958, 8242.29940455068, 8532.914670853212, 8643.91356086431, 8734.737957861274, 8925.776855578662, 9221.86167207479, 12324.815127772912, 13003.349832508526, 13075.32895558171, 13616.93191534036, 11962.342071186169, 12234.0, 12238.388080595756, 12262.08034397406, 12297.93851030775, 11749.47127379253, 12114.75770484603, 12131.939340303596, 12197.75604487923, 12299.200551964093, 12092.576759813364, 12134.878651213376, 12387.504499819906, 12516.812247816108, 12592.433340499516, 8443.324534037385, 8452.197041281068, 8548.487090774574, 8759.737207883774, 8906.955465222632, 11067.632198383939, 11461.140414469115, 11759.47082381312, 11849.289042657469, 11865.288082715064], "value": 9385.422168232244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.6073818961597, 1453.6729235921916, 1488.903221290616, 1615.1762601073456, 1785.535760702217, 8541.957290213548, 8905.465672059681, 8926.330525210611, 9155.450672959627, 9172.54137293136, 8887.422317549355, 9053.139951704594, 9071.72784816455, 9078.455292682444, 9088.77278068047, 2091.7176181215495, 2319.1766922742436, 2367.95264094718, 2400.291913885408, 2407.4944261705064, 2371.395294199985, 2431.57447446697, 2431.6230984197477, 2438.061346381647, 2438.6585877977095, 2339.63735620979, 2344.78896899279, 2380.9166679166233, 2385.3321070100315, 2386.5823480890776, 2003.5892642008353, 2194.967075493869, 2252.662100684894, 2259.1641092795608, 2362.681038059857, 2287.1308902617066, 2316.2356422380576, 2345.859248445082, 2346.0733010460945, 2346.6597343385115, 8854.380193386402, 8972.8654070189, 9010.86483702745, 9013.459192448474, 9016.233620142295, 5320.095583750772, 5448.182772584105, 5451.400345961941, 5458.863528411782, 5465.808696695636, 3249.69127932846, 3378.527006219131, 3380.6619338066243, 3405.165734395064, 3453.0504111369323, 1011.5245834457793, 1013.6198925402974, 1023.3808545829814, 1036.3626369782605, 1038.5897570459701, 12698.174618649758, 12813.615591532176, 12921.160124591872, 12946.093773435769, 12946.417411216518, 4552.726836389827, 4635.188841952645, 4738.010035784979, 4754.358161648202, 4811.518848115161, 10961.506732197071, 10986.121110311316, 10986.615468458725, 10989.175811814146, 10993.065589424989, 5396.514313711785, 5410.188471729272, 5410.91883621746, 5411.0, 5420.105682562412, 4421.248387774086, 4852.2479015752615, 5000.874978125576, 5001.649884508122, 5009.874753131201, 4050.144648023146, 4075.1034772350035, 4119.938200926988, 4134.069834287321, 4175.185838761412, 1245.582729785514, 1250.6685728282011, 1265.5760320292804, 1273.2615083251692, 1277.8466584009977, 883.5096521430668, 969.0067680627413, 1022.7238645565656, 1045.0855501436242, 1049.4228174503992, 6001.609895356788, 6182.207159923571, 6203.503719702413, 6240.594361366497, 6432.421082102634, 442.84500424851046, 455.97036192648034, 462.2373084410682, 471.8042012564747, 471.86080106368706, 4220.915581688349, 4240.088380998101, 4258.276093064124, 4269.423627810268, 4294.141171765659, 10989.835152472719, 11362.545498180145, 11366.261193022427, 11412.657620271406, 11427.771444571063, 11291.266067705574, 11306.886931130583, 11308.151888608387, 11313.094952403788, 11318.660440186808, 7990.161033091558, 8252.05101413345, 8272.131426200283, 8415.873761893576, 8454.182350794608, 5989.910151347821, 6385.10608514799, 6411.954321697343, 6414.198225221848, 6427.839304017437, 9894.307398482037, 10308.690739277834, 10347.793044139225, 10450.68647940563, 10563.154947604327, 10339.896601034194, 10534.52594633228, 10558.683239502827, 10682.89317106819, 10703.411312377893, 7001.614911179934, 7596.278353556403, 7840.255175758294, 7870.819377093482, 7980.760577182694, 8819.867701984347, 8835.514046727492, 8865.157810008039, 8901.376903616943, 8913.064128266438, 7550.8867366990635, 7681.615919203906, 7805.0, 7868.449208555347, 7949.125596184531, 7455.440841936768, 7729.884051739116, 7809.492382995314, 7870.488418252795, 7886.68453261886, 6934.479914006369, 6985.965070174617, 7001.0, 7001.964990175016, 7013.719451222098, 4736.8578942631775, 4839.249916262985, 4927.630427718007, 4965.155923492943, 4981.427135879276, 5267.3152490176035, 5270.657407268515, 5344.893102138013, 5354.464553544614, 5386.973065134649], "value": 4622.261045534817, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.85010894988307, 333.3666034534384, 338.53282470191135, 338.9406853800584, 339.82668838892175, 5348.973255133724, 5398.48714372135, 5404.513758716355, 5409.891802163955, 5431.945680543194, 5258.92111618326, 5297.523222909937, 5313.9734301328535, 5337.359516857982, 5338.786448542053, 3973.9205215895663, 4045.554988951213, 4165.687573431989, 4201.432806571104, 4204.32730763078, 4092.4679791627195, 4149.232392007473, 4168.874933751992, 4171.791410429481, 4190.811413486401, 4143.171365726852, 4146.253674338618, 4147.9585204148025, 4150.43969064177, 4169.082801783603, 3936.7047471439614, 3957.0, 4108.239975604522, 4111.403846442279, 4121.722266097519, 3660.158163622382, 3677.632236776301, 3679.7608155469807, 3681.5950245472977, 3682.2635472905527, 5049.64652474327, 5053.357658760918, 5058.1927030498055, 5062.645614806965, 5070.7464626768515, 4367.432233809616, 4667.393238878958, 4669.6497762667595, 4684.0, 4685.390899183119, 5451.454854514556, 5457.945420545783, 5464.535514481274, 5468.316460442445, 5487.0, 3943.98028009861, 3955.694620775166, 3956.2285354355913, 3983.880483585468, 3990.900227494336, 5448.210009548633, 5615.9157612635845, 5677.17680936262, 5718.48533631971, 5803.854903627401, 4024.0, 4029.6776257899296, 4040.4343391925154, 4044.292248856438, 4067.1255680028935, 4081.4490043844294, 4093.406456063854, 4093.4269202311702, 4095.815688294034, 4099.098198396348, 4546.181687296318, 4623.791929363187, 4669.322948172564, 4674.766261686902, 4740.502247264057, 5514.420985796514, 5518.0, 5531.2809334787025, 5605.159226116115, 5618.578606604521, 1402.4039783092146, 1414.653409914557, 1419.5315545870044, 1420.9342992755433, 1425.3585886351184, 883.3448021746881, 898.8292224477328, 908.6274627402734, 925.0703043441298, 939.5396255834592, 5350.705711185922, 5353.143497040533, 5378.327709036371, 5389.622726409114, 5405.0, 5597.63615365, 5598.272224610774, 5625.859353516113, 5630.718464076862, 5644.209810626516, 5058.974705126451, 5313.57491400687, 5332.760025798849, 5338.652987555796, 5349.0, 3003.7684549334667, 3005.1435340927733, 3014.8694239660126, 3024.4253591817483, 3028.1369809604157, 5864.970675146682, 5887.381824908323, 5904.1734157218025, 5911.226632010465, 5921.881562368729, 5521.00621888056, 5755.381301507804, 5791.710414479259, 5839.328477225088, 5853.824385268449, 5996.730147143389, 6004.189434426384, 6006.699665016732, 6010.016694490808, 6017.338092809788, 5474.616776825584, 5737.340205876378, 5741.741621626953, 5754.741036653444, 5799.884002320015, 5614.943850561442, 5656.321241451053, 5658.971705141613, 5675.836453527099, 5678.261825962763, 5971.701414929149, 6008.969955150196, 6009.278886533644, 6015.6691381974415, 6020.337762845996, 3803.782789507442, 3993.960060399359, 4002.9599704002585, 4006.4991876015497, 4018.1160144768105, 5651.095824668033, 5684.545236381162, 5690.260266165372, 5721.771129154954, 5724.971375143097, 5301.867453313698, 5540.0, 5553.278073850373, 5576.358718747396, 5577.6295074593945, 5506.724663766876, 5522.420145884785, 5530.529904957963, 5538.529225015919, 5547.833564993057, 5260.263563101245, 5401.514583489572, 5435.967166238402, 5441.455854414527, 5454.2091396746455, 5442.238086667949, 5564.888702225851, 5602.0, 5609.242752228397, 5612.0, 5426.918596220981, 5439.673619582838, 5452.372977107683, 5485.177223416519, 5492.313460817398], "value": 4226.955283485271, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.8797180422936, 834.6953362022862, 840.7898025493627, 848.465466755944, 852.7100785732849, 13072.281024543647, 13203.801942970838, 13217.867821321785, 13229.140105893135, 13468.124571902832, 13485.797713034288, 13501.0, 13534.187948723058, 13535.91712662987, 13541.255230962293, 671.9496037797161, 778.3695206882416, 794.0986979777965, 796.2753893956501, 799.848028874512, 774.0324594257179, 778.1284960843834, 780.1379475679378, 780.2041917244408, 781.0432220529834, 847.6905929335779, 848.1306660672828, 848.2365870716343, 848.9363297752662, 849.9787505312355, 709.2588245283665, 835.1356346181703, 844.6410275632832, 846.1792061700172, 847.7117779954845, 622.6450922973906, 623.323693792236, 623.5697368815503, 624.0296339192554, 624.4036944717784, 12739.108262421634, 12745.0, 12751.74496510074, 12782.10525263232, 12797.104202705814, 12953.935230323883, 13282.203067815866, 13324.200547967055, 13459.528916487876, 13598.11612245201, 11642.301461912228, 11743.249101790501, 11849.637291711391, 11901.0, 12278.324692141929, 4321.569171881041, 4350.912981740347, 4401.889952751175, 4424.40270563473, 4477.70894891831, 55761.0, 55979.440205598235, 56536.71731641357, 58624.41375586232, 59011.704941475444, 10675.25273230882, 10795.730106747395, 10845.13238940883, 11023.669289921316, 11024.779504410028, 18267.903925764498, 18277.54306142357, 18313.450596482126, 18321.267149314146, 18400.0, 8002.759917202493, 8167.754967350989, 8222.054463736627, 8437.704680336159, 8463.111373305837, 4661.207594708908, 4721.386219791405, 4723.102610504062, 4807.0, 4952.678075925125, 3402.217489977319, 3516.6307537708685, 3524.4360902255517, 3526.1713497328105, 3526.8765593204116, 590.2150140313373, 650.9674516274167, 657.1030543308445, 660.8083655739878, 696.022088965005, 667.6428110960612, 677.5460441504204, 700.425650966213, 747.4543583184305, 779.9103103143211, 8985.820283594292, 9879.703608891745, 10024.79950400988, 10146.644867429604, 10384.37693738378, 585.906254999198, 612.5589575505629, 731.2212493694199, 733.6698485681464, 744.5681504727245, 4782.689125206851, 4791.377120974251, 4805.6155507559315, 4818.518148185153, 4835.734034628059, 75266.62366688241, 75504.62247688726, 76458.0, 76557.6172119147, 77010.22989770143, 52333.0, 64765.0, 65409.0, 65457.67271163709, 68586.31413685899, 54377.1843422349, 57183.0, 57371.713141434026, 57622.135667964176, 58188.70905645445, 9625.0, 9702.466364350028, 9758.365706229073, 9779.462129582942, 9972.125122794001, 36842.447363290106, 37370.25259494741, 37482.250354993295, 38242.426363605126, 39304.606953930095, 46853.0, 48368.27447588359, 48419.27371089366, 48518.757406212746, 49106.0, 12530.0, 12567.37163141821, 12694.159346894834, 12785.0, 12829.20391145259, 12610.0, 13736.725265494435, 14227.07524010936, 14274.857251427353, 14327.57017289483, 12588.685282868002, 12723.872761272269, 12835.743285134058, 13291.445383599028, 13701.931490342484, 8119.837603247784, 12667.0, 12866.935665321987, 13160.210387376788, 13777.104488208635, 11970.102242332034, 11988.400579970792, 12242.693932651755, 12448.25310481374, 12497.751663768928, 9942.906280309306, 10176.135028522658, 10273.640422585473, 10382.844257335995, 10405.375677459377, 10331.431771252353, 10434.478276086316, 10546.736331591772, 10554.419506927192, 10560.260781745204], "value": 6885.017157270807, "unit": "score"}], "name": "dromaeo_css", "value": 7217.504485244714, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 110.0, 110.0, 110.0, 111.0, 112.0, 109.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 132.0, 188.0, 130.0, 127.0, 158.0, 123.0, 179.0, 124.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 162.0, 161.0, 161.0, 162.0, 160.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 119.0, 74.0, 76.0, 74.0, 75.0, 103.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 129.0, 83.0, 83.0, 84.0, 127.0, 84.0, 84.0, 118.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 54.0, 55.0, 56.0, 54.0, 72.0, 54.0, 52.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 63.0, 62.0, 61.0, 63.0, 65.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 82.0, 79.0, 86.0, 83.0, 81.0, 80.0, 87.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 120.0, 129.0, 126.0, 119.0, 129.0, 126.0, 176.0, 130.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 157.0, 158.0, 156.0, 157.0, 158.0, 169.0, 160.0, 163.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1501.9, "alertThreshold": 2.0}]} 11:33:32 INFO - Return code: 0 11:33:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:33:32 ERROR - # TBPL SUCCESS # 11:33:32 INFO - Running post-action listener: _resource_record_post_action 11:33:32 INFO - ##### 11:33:32 INFO - ##### Finished run-tests step (success) 11:33:32 INFO - ##### 11:33:32 INFO - Running post-run listener: _resource_record_post_run 11:33:32 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543371264; Read time: 16; Write time: 413556 11:33:32 INFO - TinderboxPrint: CPU usage
13.1% 11:33:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:33:32 INFO - TinderboxPrint: I/O write bytes / time
543,371,264 / 413,556 11:33:32 INFO - TinderboxPrint: CPU idle
8,252.5 (86.9%) 11:33:32 INFO - TinderboxPrint: CPU user
1,204.1 (12.7%) 11:33:32 INFO - TinderboxPrint: Swap in / out
0 / 0 11:33:32 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 249917440; Read time: 0; Write time: 221052 11:33:32 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289697792; Read time: 16; Write time: 191992 11:33:32 INFO - Running post-run listener: _upload_blobber_files 11:33:32 INFO - Blob upload gear active. 11:33:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:32 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 11:33:32 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:32 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:33 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:37 INFO - (blobuploader) - INFO - Done attempting. 11:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:38 INFO - (blobuploader) - INFO - Done attempting. 11:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:39 INFO - (blobuploader) - INFO - Done attempting. 11:33:39 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:39 INFO - Return code: 0 11:33:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23f50c8837b3a438246e55872035d093e05f90dd5bac9be86bef2308e858bf60df0e09dbdbf4be604c5cafb0fb46426665b65e15be0c7e5e9d91c824eeb75085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2df3dfa2b010198019051d6bcaabb79330fd334e859784d63af65729e316d603965e95e8cbf22f5cd2799085eecd54935fbebd1b76475bff17fa4ed832302610", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7514f2a16c89aa541d228d81af738038cc242039b26557d7473fed27b50a97f5412d2a98527831e6d3596552d8eb837608c55fe7847450e66069e5247c2fceae"} 11:33:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:39 INFO - Contents: 11:33:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23f50c8837b3a438246e55872035d093e05f90dd5bac9be86bef2308e858bf60df0e09dbdbf4be604c5cafb0fb46426665b65e15be0c7e5e9d91c824eeb75085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2df3dfa2b010198019051d6bcaabb79330fd334e859784d63af65729e316d603965e95e8cbf22f5cd2799085eecd54935fbebd1b76475bff17fa4ed832302610", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7514f2a16c89aa541d228d81af738038cc242039b26557d7473fed27b50a97f5412d2a98527831e6d3596552d8eb837608c55fe7847450e66069e5247c2fceae"} 11:33:39 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:39 INFO - Copying logs to upload dir... 11:33:39 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.779176 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-24 11:33:37.780987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 11:33:37.784105) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066 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/sha512/23f50c8837b3a438246e55872035d093e05f90dd5bac9be86bef2308e858bf60df0e09dbdbf4be604c5cafb0fb46426665b65e15be0c7e5e9d91c824eeb75085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2df3dfa2b010198019051d6bcaabb79330fd334e859784d63af65729e316d603965e95e8cbf22f5cd2799085eecd54935fbebd1b76475bff17fa4ed832302610", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7514f2a16c89aa541d228d81af738038cc242039b26557d7473fed27b50a97f5412d2a98527831e6d3596552d8eb837608c55fe7847450e66069e5247c2fceae"} build_url:https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/WLvLKUHaSiyv0hrP2rUEvg/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/sha512/23f50c8837b3a438246e55872035d093e05f90dd5bac9be86bef2308e858bf60df0e09dbdbf4be604c5cafb0fb46426665b65e15be0c7e5e9d91c824eeb75085", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2df3dfa2b010198019051d6bcaabb79330fd334e859784d63af65729e316d603965e95e8cbf22f5cd2799085eecd54935fbebd1b76475bff17fa4ed832302610", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7514f2a16c89aa541d228d81af738038cc242039b26557d7473fed27b50a97f5412d2a98527831e6d3596552d8eb837608c55fe7847450e66069e5247c2fceae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 11:33:37.811415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 11:33:37.812140) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1464113583.691819-734688066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 11:33:37.893667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 11:33:37.894127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 11:33:37.894432) ========= ========= Total master_lag: 0.16 =========