builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1459182251.18 results: success (0) buildid: 20160328082423 builduid: 106be77b7e554ae8ac4ca44a18f65cab revision: 3f54e19a24326db7c75d49ee000d53db6b628c83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.181657) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.182186) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.182507) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004532 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.227250) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.227867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.321032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.321340) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.379479) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.379791) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.380171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.380720) ========= 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=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-28 09:24:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-03-28 09:24:11 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163534 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.580400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.580724) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017567 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:11.651334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-28 09:24:11.651693) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3f54e19a24326db7c75d49ee000d53db6b628c83 --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 3f54e19a24326db7c75d49ee000d53db6b628c83 --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=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-28 09:24:11,906 truncating revision to first 12 chars 2016-03-28 09:24:11,906 Setting DEBUG logging. 2016-03-28 09:24:11,906 attempt 1/10 2016-03-28 09:24:11,906 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3f54e19a2432?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 09:24:12,668 unpacking tar archive at: fx-team-3f54e19a2432/testing/mozharness/ program finished with exit code 0 elapsedTime=1.125368 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-28 09:24:12.793364) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:12.793847) ========= echo 3f54e19a24326db7c75d49ee000d53db6b628c83 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3f54e19a24326db7c75d49ee000d53db6b628c83'] 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=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3f54e19a24326db7c75d49ee000d53db6b628c83 program finished with exit code 0 elapsedTime=0.004817 script_repo_revision: '3f54e19a24326db7c75d49ee000d53db6b628c83' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:12.845223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:12.845534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 09:24:12.856252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-28 09:24:12.856868) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:24:13 INFO - MultiFileLogger online at 20160328 09:24:13 in /builds/slave/test 09:24:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:24:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:13 INFO - {'append_to_log': False, 09:24:13 INFO - 'base_work_dir': '/builds/slave/test', 09:24:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:24:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:13 INFO - 'branch': 'Fx-Team-Non-PGO', 09:24:13 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:13 INFO - 'config_files': ('talos/linux_config.py',), 09:24:13 INFO - 'default_actions': ('clobber', 09:24:13 INFO - 'read-buildbot-config', 09:24:13 INFO - 'download-and-extract', 09:24:13 INFO - 'populate-webroot', 09:24:13 INFO - 'create-virtualenv', 09:24:13 INFO - 'install', 09:24:13 INFO - 'run-tests'), 09:24:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:13 INFO - 'download_minidump_stackwalk': True, 09:24:13 INFO - 'download_symbols': 'ondemand', 09:24:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:13 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:13 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:13 INFO - 'installer_path': 'installer.exe', 09:24:13 INFO - 'log_level': 'info', 09:24:13 INFO - 'log_name': 'talos', 09:24:13 INFO - 'log_to_console': True, 09:24:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:24:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:24:13 INFO - 'opt_config_files': (), 09:24:13 INFO - 'pip_index': False, 09:24:13 INFO - 'sps_profile': False, 09:24:13 INFO - 'sps_profile_interval': 0, 09:24:13 INFO - 'suite': 'dromaeojs', 09:24:13 INFO - 'system_bits': '32', 09:24:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:13 INFO - 'title': 'talos-linux64-ix-003', 09:24:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:13 INFO - 'use_talos_json': True, 09:24:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:13 INFO - 'work_dir': 'build'} 09:24:13 INFO - ##### 09:24:13 INFO - ##### Running clobber step. 09:24:13 INFO - ##### 09:24:13 INFO - Running pre-action listener: _resource_record_pre_action 09:24:13 INFO - Running main action method: clobber 09:24:13 INFO - rmtree: /builds/slave/test/build 09:24:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:13 INFO - Running post-action listener: _resource_record_post_action 09:24:13 INFO - ##### 09:24:13 INFO - ##### Running read-buildbot-config step. 09:24:13 INFO - ##### 09:24:13 INFO - Running pre-action listener: _resource_record_pre_action 09:24:13 INFO - Running main action method: read_buildbot_config 09:24:13 INFO - Using buildbot properties: 09:24:13 INFO - { 09:24:13 INFO - "project": "", 09:24:13 INFO - "product": "firefox", 09:24:13 INFO - "script_repo_revision": "production", 09:24:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:24:13 INFO - "repository": "", 09:24:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:24:13 INFO - "buildid": "20160328082423", 09:24:13 INFO - "pgo_build": "False", 09:24:13 INFO - "basedir": "/builds/slave/test", 09:24:13 INFO - "buildnumber": 2709, 09:24:13 INFO - "slavename": "talos-linux64-ix-003", 09:24:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:24:13 INFO - "platform": "ubuntu64_hw", 09:24:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:24:13 INFO - "branch": "fx-team", 09:24:13 INFO - "repo_path": "integration/fx-team", 09:24:13 INFO - "revision": "3f54e19a24326db7c75d49ee000d53db6b628c83", 09:24:13 INFO - "stage_platform": "linux64", 09:24:13 INFO - "builduid": "106be77b7e554ae8ac4ca44a18f65cab", 09:24:13 INFO - "slavebuilddir": "test" 09:24:13 INFO - } 09:24:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:24:13 INFO - Running post-action listener: _resource_record_post_action 09:24:13 INFO - ##### 09:24:13 INFO - ##### Running download-and-extract step. 09:24:13 INFO - ##### 09:24:13 INFO - Running pre-action listener: _resource_record_pre_action 09:24:13 INFO - Running main action method: download_and_extract 09:24:13 INFO - mkdir: /builds/slave/test/build/tests 09:24:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:13 INFO - https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:24:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:24:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:24:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:24:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:24:23 INFO - Downloaded 1361 bytes. 09:24:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:24:23 INFO - Using the following test package requirements: 09:24:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:24:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:24:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:23 INFO - u'jsshell-linux-x86_64.zip'], 09:24:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:24:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:24:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:24:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:24:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:24:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:24:23 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')]} 09:24:23 INFO - https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:24:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:24:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:24:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:24:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:24:38 INFO - Downloaded 22085590 bytes. 09:24:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:24:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:24:39 INFO - Return code: 0 09:24:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:39 INFO - https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:24:41 INFO - Downloaded 22085590 bytes. 09:24:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:24:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:24:42 INFO - Return code: 0 09:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:42 INFO - https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:24:44 INFO - Downloaded 10847531 bytes. 09:24:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:24:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:24:44 INFO - Return code: 0 09:24:44 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')]} 09:24:44 INFO - https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:24:47 INFO - Downloaded 54264233 bytes. 09:24:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:24:47 INFO - mkdir: /builds/slave/test/properties 09:24:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:47 INFO - Contents: 09:24:47 INFO - build_url:https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:24:48 INFO - Running post-action listener: _resource_record_post_action 09:24:48 INFO - Running post-action listener: set_extra_try_arguments 09:24:48 INFO - ##### 09:24:48 INFO - ##### Running populate-webroot step. 09:24:48 INFO - ##### 09:24:48 INFO - Running pre-action listener: _resource_record_pre_action 09:24:48 INFO - Running main action method: populate_webroot 09:24:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:48 INFO - '--tppagecycles', 09:24:48 INFO - '7'], 09:24:48 INFO - 'tests': ['tsvgm']}}, 09:24:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:24:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:24:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:48 INFO - 'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:48 INFO - 'tests': ['damp', 'tps']}, 09:24:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:48 INFO - 'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['damp', 'tps']}, 09:24:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:24:48 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['dromaeo_dom']}, 09:24:48 INFO - 'other': {'tests': ['a11yr', 09:24:48 INFO - 'ts_paint', 09:24:48 INFO - 'tpaint', 09:24:48 INFO - 'sessionrestore', 09:24:48 INFO - 'sessionrestore_no_auto_restore', 09:24:48 INFO - 'tabpaint']}, 09:24:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['a11yr', 09:24:48 INFO - 'ts_paint', 09:24:48 INFO - 'tpaint', 09:24:48 INFO - 'sessionrestore', 09:24:48 INFO - 'sessionrestore_no_auto_restore', 09:24:48 INFO - 'tabpaint']}, 09:24:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['a11yr', 09:24:48 INFO - 'ts_paint', 09:24:48 INFO - 'tpaint', 09:24:48 INFO - 'sessionrestore', 09:24:48 INFO - 'sessionrestore_no_auto_restore', 09:24:48 INFO - 'tabpaint']}, 09:24:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['a11yr', 09:24:48 INFO - 'ts_paint', 09:24:48 INFO - 'tpaint', 09:24:48 INFO - 'sessionrestore', 09:24:48 INFO - 'sessionrestore_no_auto_restore', 09:24:48 INFO - 'tabpaint']}, 09:24:48 INFO - 'other_l64': {'tests': ['a11yr', 09:24:48 INFO - 'ts_paint', 09:24:48 INFO - 'tpaint', 09:24:48 INFO - 'sessionrestore', 09:24:48 INFO - 'sessionrestore_no_auto_restore', 09:24:48 INFO - 'tabpaint']}, 09:24:48 INFO - 'other_nol64': {'tests': ['a11yr', 09:24:48 INFO - 'ts_paint', 09:24:48 INFO - 'tpaint', 09:24:48 INFO - 'sessionrestore', 09:24:48 INFO - 'sessionrestore_no_auto_restore', 09:24:48 INFO - 'tabpaint']}, 09:24:48 INFO - 'svgr': {'tests': ['tsvgx', 09:24:48 INFO - 'tsvgr_opacity', 09:24:48 INFO - 'tart', 09:24:48 INFO - 'tscrollx', 09:24:48 INFO - 'cart']}, 09:24:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['tsvgx', 09:24:48 INFO - 'tsvgr_opacity', 09:24:48 INFO - 'tart', 09:24:48 INFO - 'tscrollx', 09:24:48 INFO - 'cart']}, 09:24:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:48 INFO - 'tests': ['tp5o']}, 09:24:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:48 INFO - 'talos_options': ['--e10s'], 09:24:48 INFO - 'tests': ['tp5o']}, 09:24:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:48 INFO - 'talos_options': ['--xperf_path', 09:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:48 INFO - 'tests': ['tp5n']}, 09:24:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:48 INFO - 'talos_options': ['--e10s', 09:24:48 INFO - '--xperf_path', 09:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:48 INFO - 'tests': ['tp5n']}}, 09:24:48 INFO - 'talos.zip': {'path': '', 09:24:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:48 INFO - Running post-action listener: _resource_record_post_action 09:24:48 INFO - ##### 09:24:48 INFO - ##### Running create-virtualenv step. 09:24:48 INFO - ##### 09:24:48 INFO - Running pre-action listener: _resource_record_pre_action 09:24:48 INFO - Running main action method: create_virtualenv 09:24:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:48 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 09:24:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:48 INFO - Using real prefix '/usr' 09:24:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:50 INFO - Installing pip.................done. 09:24:50 INFO - Return code: 0 09:24:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:50 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')]} 09:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:50 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')]} 09:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:50 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 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:24:50 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 09:24:50 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 09:24:50 INFO - Using env: {'DISPLAY': ':0', 09:24:50 INFO - 'HOME': '/home/cltbld', 09:24:50 INFO - 'LANG': 'en_US.UTF-8', 09:24:50 INFO - 'LANGUAGE': 'en_US:en', 09:24:50 INFO - 'LOGNAME': 'cltbld', 09:24:50 INFO - 'MAIL': '/var/mail/cltbld', 09:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:50 INFO - 'MOZ_NO_REMOTE': '1', 09:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:50 INFO - 'NO_EM_RESTART': '1', 09:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:50 INFO - 'PWD': '/builds/slave/test', 09:24:50 INFO - 'SHELL': '/bin/bash', 09:24:50 INFO - 'SHLVL': '1', 09:24:50 INFO - 'TERM': 'linux', 09:24:50 INFO - 'TMOUT': '86400', 09:24:50 INFO - 'USER': 'cltbld', 09:24:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:50 INFO - '_': '/tools/buildbot/bin/python'} 09:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:51 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 09:24:51 INFO - Cleaning up... 09:24:51 INFO - Return code: 0 09:24:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:24:51 INFO - Using env: {'DISPLAY': ':0', 09:24:51 INFO - 'HOME': '/home/cltbld', 09:24:51 INFO - 'LANG': 'en_US.UTF-8', 09:24:51 INFO - 'LANGUAGE': 'en_US:en', 09:24:51 INFO - 'LOGNAME': 'cltbld', 09:24:51 INFO - 'MAIL': '/var/mail/cltbld', 09:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:51 INFO - 'MOZ_NO_REMOTE': '1', 09:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:51 INFO - 'NO_EM_RESTART': '1', 09:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:51 INFO - 'PWD': '/builds/slave/test', 09:24:51 INFO - 'SHELL': '/bin/bash', 09:24:51 INFO - 'SHLVL': '1', 09:24:51 INFO - 'TERM': 'linux', 09:24:51 INFO - 'TMOUT': '86400', 09:24:51 INFO - 'USER': 'cltbld', 09:24:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:51 INFO - '_': '/tools/buildbot/bin/python'} 09:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:51 INFO - Downloading/unpacking psutil>=0.7.1 09:24:51 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 09:24:51 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 09:24:51 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 09:24:51 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 09:24:51 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 09:24:51 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 09:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:53 INFO - Installing collected packages: psutil 09:24:53 INFO - Running setup.py install for psutil 09:24:53 INFO - building 'psutil._psutil_linux' extension 09:24:53 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 09:24:53 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 09:24:53 INFO - building 'psutil._psutil_posix' extension 09:24:53 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 09:24:53 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 09:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:53 INFO - Successfully installed psutil 09:24:53 INFO - Cleaning up... 09:24:53 INFO - Return code: 0 09:24:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:24:53 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')]} 09:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:53 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')]} 09:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:24:53 INFO - Using env: {'DISPLAY': ':0', 09:24:53 INFO - 'HOME': '/home/cltbld', 09:24:53 INFO - 'LANG': 'en_US.UTF-8', 09:24:53 INFO - 'LANGUAGE': 'en_US:en', 09:24:53 INFO - 'LOGNAME': 'cltbld', 09:24:53 INFO - 'MAIL': '/var/mail/cltbld', 09:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:53 INFO - 'MOZ_NO_REMOTE': '1', 09:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:53 INFO - 'NO_EM_RESTART': '1', 09:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:53 INFO - 'PWD': '/builds/slave/test', 09:24:53 INFO - 'SHELL': '/bin/bash', 09:24:53 INFO - 'SHLVL': '1', 09:24:53 INFO - 'TERM': 'linux', 09:24:53 INFO - 'TMOUT': '86400', 09:24:53 INFO - 'USER': 'cltbld', 09:24:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:53 INFO - '_': '/tools/buildbot/bin/python'} 09:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:24:54 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 09:24:54 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 09:24:54 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 09:24:54 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 09:24:54 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 09:24:54 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 09:24:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:24:55 INFO - Installing collected packages: mozsystemmonitor 09:24:55 INFO - Running setup.py install for mozsystemmonitor 09:24:56 INFO - Successfully installed mozsystemmonitor 09:24:56 INFO - Cleaning up... 09:24:56 INFO - Return code: 0 09:24:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:56 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')]} 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 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')]} 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 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 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:24:56 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 09:24:56 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 09:24:56 INFO - Using env: {'DISPLAY': ':0', 09:24:56 INFO - 'HOME': '/home/cltbld', 09:24:56 INFO - 'LANG': 'en_US.UTF-8', 09:24:56 INFO - 'LANGUAGE': 'en_US:en', 09:24:56 INFO - 'LOGNAME': 'cltbld', 09:24:56 INFO - 'MAIL': '/var/mail/cltbld', 09:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:56 INFO - 'MOZ_NO_REMOTE': '1', 09:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:56 INFO - 'NO_EM_RESTART': '1', 09:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:56 INFO - 'PWD': '/builds/slave/test', 09:24:56 INFO - 'SHELL': '/bin/bash', 09:24:56 INFO - 'SHLVL': '1', 09:24:56 INFO - 'TERM': 'linux', 09:24:56 INFO - 'TMOUT': '86400', 09:24:56 INFO - 'USER': 'cltbld', 09:24:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:56 INFO - '_': '/tools/buildbot/bin/python'} 09:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:58 INFO - Downloading docopt-0.6.1.tar.gz 09:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:58 INFO - Running setup.py install for blobuploader 09:24:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:58 INFO - Running setup.py install for requests 09:24:59 INFO - Running setup.py install for docopt 09:24:59 INFO - Successfully installed blobuploader requests docopt 09:24:59 INFO - Cleaning up... 09:24:59 INFO - Return code: 0 09:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:59 INFO - Using env: {'DISPLAY': ':0', 09:24:59 INFO - 'HOME': '/home/cltbld', 09:24:59 INFO - 'LANG': 'en_US.UTF-8', 09:24:59 INFO - 'LANGUAGE': 'en_US:en', 09:24:59 INFO - 'LOGNAME': 'cltbld', 09:24:59 INFO - 'MAIL': '/var/mail/cltbld', 09:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:59 INFO - 'MOZ_NO_REMOTE': '1', 09:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:59 INFO - 'NO_EM_RESTART': '1', 09:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:59 INFO - 'PWD': '/builds/slave/test', 09:24:59 INFO - 'SHELL': '/bin/bash', 09:24:59 INFO - 'SHLVL': '1', 09:24:59 INFO - 'TERM': 'linux', 09:24:59 INFO - 'TMOUT': '86400', 09:24:59 INFO - 'USER': 'cltbld', 09:24:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:59 INFO - '_': '/tools/buildbot/bin/python'} 09:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:59 INFO - Running setup.py (path:/tmp/pip-2JrMZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:59 INFO - Running setup.py (path:/tmp/pip-rv2VFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:59 INFO - Running setup.py (path:/tmp/pip-I0bksw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:59 INFO - Running setup.py (path:/tmp/pip-zEpKPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:59 INFO - Running setup.py (path:/tmp/pip-5K4dOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:00 INFO - Running setup.py (path:/tmp/pip-jQHN0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:00 INFO - Running setup.py (path:/tmp/pip-3Nv3fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:00 INFO - Running setup.py (path:/tmp/pip-kJ3UxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:00 INFO - Running setup.py (path:/tmp/pip-gP9JzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:00 INFO - Running setup.py (path:/tmp/pip-DDSiHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:00 INFO - Running setup.py (path:/tmp/pip-yb_fqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:00 INFO - Running setup.py (path:/tmp/pip-XT7atL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:00 INFO - Running setup.py (path:/tmp/pip-segmzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:00 INFO - Running setup.py (path:/tmp/pip-s3h85C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:00 INFO - Running setup.py (path:/tmp/pip-GRKl5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:00 INFO - Running setup.py (path:/tmp/pip-Myyt_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:00 INFO - Running setup.py (path:/tmp/pip-MqL1Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:00 INFO - Running setup.py install for manifestparser 09:25:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Running setup.py install for mozcrash 09:25:01 INFO - Running setup.py install for mozdebug 09:25:01 INFO - Running setup.py install for mozdevice 09:25:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Running setup.py install for mozfile 09:25:01 INFO - Running setup.py install for mozhttpd 09:25:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Running setup.py install for mozinfo 09:25:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Running setup.py install for mozInstall 09:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Running setup.py install for mozleak 09:25:01 INFO - Running setup.py install for mozlog 09:25:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:01 INFO - Running setup.py install for moznetwork 09:25:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for mozprocess 09:25:02 INFO - Running setup.py install for mozprofile 09:25:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for mozrunner 09:25:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for mozscreenshot 09:25:02 INFO - Running setup.py install for moztest 09:25:02 INFO - Running setup.py install for mozversion 09:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:02 INFO - Cleaning up... 09:25:02 INFO - Return code: 0 09:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:25:02 INFO - Using env: {'DISPLAY': ':0', 09:25:02 INFO - 'HOME': '/home/cltbld', 09:25:02 INFO - 'LANG': 'en_US.UTF-8', 09:25:02 INFO - 'LANGUAGE': 'en_US:en', 09:25:02 INFO - 'LOGNAME': 'cltbld', 09:25:02 INFO - 'MAIL': '/var/mail/cltbld', 09:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:02 INFO - 'MOZ_NO_REMOTE': '1', 09:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:02 INFO - 'NO_EM_RESTART': '1', 09:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:02 INFO - 'PWD': '/builds/slave/test', 09:25:02 INFO - 'SHELL': '/bin/bash', 09:25:02 INFO - 'SHLVL': '1', 09:25:02 INFO - 'TERM': 'linux', 09:25:02 INFO - 'TMOUT': '86400', 09:25:02 INFO - 'USER': 'cltbld', 09:25:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:02 INFO - '_': '/tools/buildbot/bin/python'} 09:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:02 INFO - Running setup.py (path:/tmp/pip-w9KtXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:02 INFO - Running setup.py (path:/tmp/pip-94l6ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:03 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)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:03 INFO - Running setup.py (path:/tmp/pip-0mdlFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:03 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)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:03 INFO - Running setup.py (path:/tmp/pip-9SLajq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:03 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)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:03 INFO - Running setup.py (path:/tmp/pip-RxHCIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:03 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)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:03 INFO - Running setup.py (path:/tmp/pip-fRs1FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:03 INFO - Running setup.py (path:/tmp/pip-hATNnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:03 INFO - Running setup.py (path:/tmp/pip-sozbXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:03 INFO - Running setup.py (path:/tmp/pip-Tsgrll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:03 INFO - Running setup.py (path:/tmp/pip-Nxf1Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:03 INFO - Running setup.py (path:/tmp/pip-_gLeTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:03 INFO - Running setup.py (path:/tmp/pip-9eDZWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:03 INFO - Running setup.py (path:/tmp/pip-aCXpT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:03 INFO - Running setup.py (path:/tmp/pip-E9kslS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:03 INFO - Running setup.py (path:/tmp/pip-V3wFRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:04 INFO - Running setup.py (path:/tmp/pip-R4kWcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:04 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)) 09:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:04 INFO - Running setup.py (path:/tmp/pip-uoxfIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:04 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)) 09:25:04 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)) 09:25:04 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)) 09:25:04 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)) 09:25:04 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)) 09:25:04 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)) 09:25:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:05 INFO - Downloading blessings-1.6.tar.gz 09:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:06 INFO - Installing collected packages: blessings 09:25:06 INFO - Running setup.py install for blessings 09:25:06 INFO - Successfully installed blessings 09:25:06 INFO - Cleaning up... 09:25:06 INFO - Return code: 0 09:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:06 INFO - Reading from file tmpfile_stdout 09:25:06 INFO - Current package versions: 09:25:06 INFO - argparse == 1.2.1 09:25:06 INFO - blessings == 1.6 09:25:06 INFO - blobuploader == 1.2.4 09:25:06 INFO - docopt == 0.6.1 09:25:06 INFO - manifestparser == 1.1 09:25:06 INFO - mozInstall == 1.12 09:25:06 INFO - mozcrash == 0.17 09:25:06 INFO - mozdebug == 0.1 09:25:06 INFO - mozdevice == 0.48 09:25:06 INFO - mozfile == 1.2 09:25:06 INFO - mozhttpd == 0.7 09:25:06 INFO - mozinfo == 0.9 09:25:06 INFO - mozleak == 0.1 09:25:06 INFO - mozlog == 3.1 09:25:06 INFO - moznetwork == 0.27 09:25:06 INFO - mozprocess == 0.22 09:25:06 INFO - mozprofile == 0.28 09:25:06 INFO - mozrunner == 6.11 09:25:06 INFO - mozscreenshot == 0.1 09:25:06 INFO - mozsystemmonitor == 0.0 09:25:06 INFO - moztest == 0.7 09:25:06 INFO - mozversion == 1.4 09:25:06 INFO - psutil == 3.1.1 09:25:06 INFO - requests == 1.2.3 09:25:06 INFO - wsgiref == 0.1.2 09:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 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 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:25:06 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 09:25:06 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 09:25:06 INFO - Using env: {'DISPLAY': ':0', 09:25:06 INFO - 'HOME': '/home/cltbld', 09:25:06 INFO - 'LANG': 'en_US.UTF-8', 09:25:06 INFO - 'LANGUAGE': 'en_US:en', 09:25:06 INFO - 'LOGNAME': 'cltbld', 09:25:06 INFO - 'MAIL': '/var/mail/cltbld', 09:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:06 INFO - 'MOZ_NO_REMOTE': '1', 09:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:06 INFO - 'NO_EM_RESTART': '1', 09:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:06 INFO - 'PWD': '/builds/slave/test', 09:25:06 INFO - 'SHELL': '/bin/bash', 09:25:06 INFO - 'SHLVL': '1', 09:25:06 INFO - 'TERM': 'linux', 09:25:06 INFO - 'TMOUT': '86400', 09:25:06 INFO - 'USER': 'cltbld', 09:25:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:06 INFO - '_': '/tools/buildbot/bin/python'} 09:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 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)) 09:25:06 INFO - Cleaning up... 09:25:06 INFO - Return code: 0 09:25:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 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 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:25:06 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 09:25:06 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 09:25:06 INFO - Using env: {'DISPLAY': ':0', 09:25:06 INFO - 'HOME': '/home/cltbld', 09:25:06 INFO - 'LANG': 'en_US.UTF-8', 09:25:06 INFO - 'LANGUAGE': 'en_US:en', 09:25:06 INFO - 'LOGNAME': 'cltbld', 09:25:06 INFO - 'MAIL': '/var/mail/cltbld', 09:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:06 INFO - 'MOZ_NO_REMOTE': '1', 09:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:06 INFO - 'NO_EM_RESTART': '1', 09:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:06 INFO - 'PWD': '/builds/slave/test', 09:25:06 INFO - 'SHELL': '/bin/bash', 09:25:06 INFO - 'SHLVL': '1', 09:25:06 INFO - 'TERM': 'linux', 09:25:06 INFO - 'TMOUT': '86400', 09:25:06 INFO - 'USER': 'cltbld', 09:25:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:06 INFO - '_': '/tools/buildbot/bin/python'} 09:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:06 INFO - Downloading/unpacking jsonschema 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:08 INFO - Downloading/unpacking functools32 (from jsonschema) 09:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:09 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:09 INFO - warning: no files found matching '*.txt' 09:25:09 INFO - no previously-included directories found matching 'build' 09:25:09 INFO - no previously-included directories found matching 'dist' 09:25:09 INFO - no previously-included directories found matching '.git*' 09:25:09 INFO - Installing collected packages: jsonschema, functools32 09:25:09 INFO - Running setup.py install for functools32 09:25:09 INFO - warning: no files found matching '*.txt' 09:25:09 INFO - no previously-included directories found matching 'build' 09:25:09 INFO - no previously-included directories found matching 'dist' 09:25:09 INFO - no previously-included directories found matching '.git*' 09:25:09 INFO - Successfully installed jsonschema functools32 09:25:09 INFO - Cleaning up... 09:25:09 INFO - Return code: 0 09:25:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:25:09 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')]} 09:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:09 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')]} 09:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:09 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 0x7f576a009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, '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': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', '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 09:25:09 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 09:25:09 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 09:25:09 INFO - Using env: {'DISPLAY': ':0', 09:25:09 INFO - 'HOME': '/home/cltbld', 09:25:09 INFO - 'LANG': 'en_US.UTF-8', 09:25:09 INFO - 'LANGUAGE': 'en_US:en', 09:25:09 INFO - 'LOGNAME': 'cltbld', 09:25:09 INFO - 'MAIL': '/var/mail/cltbld', 09:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:09 INFO - 'MOZ_NO_REMOTE': '1', 09:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:09 INFO - 'NO_EM_RESTART': '1', 09:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:09 INFO - 'PWD': '/builds/slave/test', 09:25:09 INFO - 'SHELL': '/bin/bash', 09:25:09 INFO - 'SHLVL': '1', 09:25:09 INFO - 'TERM': 'linux', 09:25:09 INFO - 'TMOUT': '86400', 09:25:09 INFO - 'USER': 'cltbld', 09:25:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:09 INFO - '_': '/tools/buildbot/bin/python'} 09:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:09 INFO - Downloading/unpacking flake8 09:25:09 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 09:25:09 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 09:25:09 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 09:25:09 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 09:25:09 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 09:25:09 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 09:25:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:25:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:25:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:25:12 INFO - no previously-included directories found matching 'docs/_build' 09:25:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:25:12 INFO - Running setup.py install for pep8 09:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:25:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:25:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:25:12 INFO - no previously-included directories found matching 'docs/_build' 09:25:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:25:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:25:12 INFO - Cleaning up... 09:25:12 INFO - Return code: 0 09:25:12 INFO - Running post-action listener: _resource_record_post_action 09:25:12 INFO - Running post-action listener: _start_resource_monitoring 09:25:12 INFO - Starting resource monitoring. 09:25:12 INFO - ##### 09:25:12 INFO - ##### Running install step. 09:25:12 INFO - ##### 09:25:12 INFO - Running pre-action listener: _resource_record_pre_action 09:25:12 INFO - Running main action method: install 09:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:12 INFO - Reading from file tmpfile_stdout 09:25:12 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:12 INFO - Reading from file tmpfile_stdout 09:25:12 INFO - Output received: 09:25:12 INFO - Usage: mozinstall [options] installer 09:25:12 INFO - Options: 09:25:12 INFO - -h, --help show this help message and exit 09:25:12 INFO - -d DEST, --destination=DEST 09:25:12 INFO - Directory to install application into. [default: 09:25:12 INFO - "/builds/slave/test"] 09:25:12 INFO - --app=APP Application being installed. [default: firefox] 09:25:12 INFO - mkdir: /builds/slave/test/build/application 09:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:25:28 INFO - Reading from file tmpfile_stdout 09:25:28 INFO - Output received: 09:25:28 INFO - /builds/slave/test/build/application/firefox/firefox 09:25:28 INFO - Running post-action listener: _resource_record_post_action 09:25:28 INFO - ##### 09:25:28 INFO - ##### Running run-tests step. 09:25:28 INFO - ##### 09:25:28 INFO - Running pre-action listener: _resource_record_pre_action 09:25:28 INFO - Running main action method: run_tests 09:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:28 INFO - Python 2.7.3 09:25:28 INFO - Return code: 0 09:25:28 INFO - grabbing minidump binary from tooltool 09:25: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')]} 09:25:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1557410>, '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 0x1558310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15587a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:28 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 09:25:28 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 09:25:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:28 INFO - Return code: 0 09:25:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:25:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:25:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:25:29 INFO - Return code: 0 09:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 09:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 09:25:29 INFO - Using env: {'DISPLAY': ':0', 09:25:29 INFO - 'HOME': '/home/cltbld', 09:25:29 INFO - 'LANG': 'en_US.UTF-8', 09:25:29 INFO - 'LANGUAGE': 'en_US:en', 09:25:29 INFO - 'LOGNAME': 'cltbld', 09:25:29 INFO - 'MAIL': '/var/mail/cltbld', 09:25:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:29 INFO - 'MOZ_NO_REMOTE': '1', 09:25:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:29 INFO - 'NO_EM_RESTART': '1', 09:25:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:29 INFO - 'PWD': '/builds/slave/test', 09:25:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:29 INFO - 'SHELL': '/bin/bash', 09:25:29 INFO - 'SHLVL': '1', 09:25:29 INFO - 'TERM': 'linux', 09:25:29 INFO - 'TMOUT': '86400', 09:25:29 INFO - 'USER': 'cltbld', 09:25:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1459181353.97208-1758109273', 09:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:29 INFO - '_': '/tools/buildbot/bin/python'} 09:25:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 09:25:29 INFO - mozversion application_buildid: 20160328082423 09:25:29 INFO - mozversion application_changeset: 3f54e19a24326db7c75d49ee000d53db6b628c83 09:25:29 INFO - mozversion application_display_name: Nightly 09:25:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:29 INFO - mozversion application_name: Firefox 09:25:29 INFO - mozversion application_remotingname: firefox 09:25:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:25:29 INFO - mozversion application_vendor: Mozilla 09:25:29 INFO - mozversion application_version: 48.0a1 09:25:29 INFO - mozversion platform_buildid: 20160328082423 09:25:29 INFO - mozversion platform_changeset: 3f54e19a24326db7c75d49ee000d53db6b628c83 09:25:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:25:29 INFO - mozversion platform_version: 48.0a1 09:25:29 INFO - using testdate: 1459182329 09:25:29 INFO - actual date: 1459182329 09:25:29 INFO - starting webserver on 'localhost:37391' 09:25:29 INFO - SUITE-START | Running 2 tests 09:25:29 INFO - TEST-START | dromaeo_css 09:25:29 INFO - operating with platform_type : linux_ 09:25:29 INFO - Initialising browser for dromaeo_css test... 09:25:29 INFO - TEST-INFO | started process 4468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoEhgad/profile http://localhost:37391/getInfo.html) 09:25:34 INFO - PROCESS | 4468 | __metrics Screen width/height:1600/1200 09:25:34 INFO - PROCESS | 4468 | colorDepth:24 09:25:34 INFO - PROCESS | 4468 | Browser inner width/height: 1024/697 09:25:34 INFO - PROCESS | 4468 | __metrics 09:25:35 ERROR - PROCESS | 4468 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:25:35 INFO - PROCESS | 4468 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:25:36 INFO - TEST-INFO | 4468: exit 0 09:25:36 INFO - Browser initialized. 09:25:36 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:36 INFO - TEST-INFO | started process 4562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoEhgad/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:48 INFO - PROCESS | 4562 | RSS: Main: 154898432 09:25:48 INFO - PROCESS | 4562 | 09:26:39 INFO - PROCESS | 4562 | 1459182399196 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] 09:28:51 INFO - PROCESS | 4562 | Cycle 1(1): loaded http://localhost:37391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37391/tests/dromaeo/cssquery-ext.html) 09:28:52 INFO - PROCESS | 4562 | RSS: Main: 243343360 09:28:52 INFO - PROCESS | 4562 | 09:31:54 INFO - PROCESS | 4562 | Cycle 1(1): loaded http://localhost:37391/tests/dromaeo/cssquery-ext.html (next: http://localhost:37391/tests/dromaeo/cssquery-jquery.html) 09:31:55 INFO - PROCESS | 4562 | RSS: Main: 238120960 09:31:55 INFO - PROCESS | 4562 | 09:34:57 INFO - PROCESS | 4562 | Cycle 1(1): loaded http://localhost:37391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37391/tests/dromaeo/cssquery-mootools.html) 09:34:57 INFO - PROCESS | 4562 | RSS: Main: 239714304 09:34:57 INFO - PROCESS | 4562 | 09:37:59 INFO - PROCESS | 4562 | Cycle 1(1): loaded http://localhost:37391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37391/tests/dromaeo/cssquery-prototype.html) 09:38:00 INFO - PROCESS | 4562 | RSS: Main: 201555968 09:38:00 INFO - PROCESS | 4562 | 09:41:02 INFO - PROCESS | 4562 | Cycle 1(1): loaded http://localhost:37391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37391/tests/dromaeo/cssquery-yui.html) 09:41:03 INFO - PROCESS | 4562 | RSS: Main: 198512640 09:41:03 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | Cycle 1(1): loaded http://localhost:37391/tests/dromaeo/cssquery-yui.html (next: http://localhost:37391/tests/dromaeo/cssquery-dojo.html) 09:44:06 INFO - PROCESS | 4562 | RSS: Main: 277123072 09:44:06 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | __start_tp_report 09:44:06 INFO - PROCESS | 4562 | _x_x_mozilla_page_load 09:44:06 INFO - PROCESS | 4562 | _x_x_mozilla_page_load_details 09:44:06 INFO - PROCESS | 4562 | |i|pagename|runs| 09:44:06 INFO - PROCESS | 4562 | |0;dojo.html;2597.2078516052607;2674.652295201625;2679.638248836409;2701.3921867579797;2704.377993061595;4653;4702.6002789762915;4738.17082010648;4743.383360163182;4743.715377077374;4630.907381852361;4688.062387522501;4689.9062018759605;4743.075100355432;4769.356136921515;4304.913901721971;4345.913081738363;4355.716878402894;4379.0366119453665;4448.177087238855;4371.846985355513;4428.955710442887;4461.241588929874;4463.196624607569;4472.865814025568;4220.134872351161;4287.249731297011;4295.78521073945;4357.716748411375;4366.541513141122;4288.656907447396;4303.483581970152;4304.311310190355;4307.138572285524;4315.892102697427;4282.635975942048;4284.9143017139795;4290.828366865321;4291;4294.720843145185;4582.908341833145;4634.698744581591;4636.976815115937;4678.415198100238;4726.645501587394;5016.372953380827;5042.949570504321;5045.520675535855;5088.338515992934;5092.083424983502;4896.436909755388;5024.824131155428;5056.595472362239;5059.898802023976;5074.112030394703;4684.297355396718;4686.27362758773;4715.033418149271;4725.5983241424865;4732.9763351183365;5059.316992206079;5101.8724531886255;5110.310108135429;5113.8721531961255;5117.632190630038;4913.434954980152;4917.164082106051;4946.431160416526;4964;5033.672811267256;5038.370203724535;5057.342545469065;5059.418166910852;5063.063333283354;5089.134847075932;5034.144195486776;5034.446210916796;5035.974820125876;5040.143175660147;5068.087744206005;4871.244957031666;4982.9252561211615;4997.350344455271;5047.369078865142;5058.1654027085115;4241.97879010603;4257.40396344512;4264.872053838328;4266.360045993064;4309.719868208556;3730.2539492101146;3748.2878253131817;3748.456473811282;3749.6250374962287;3769.4722738816586;4190.28765109932;4223.852165174266;4273.87178384649;4290.249206388869;4294.785260737013;5079.238114282887;5083.949160508348;5085.847424577269;5113.667611605234;5146.639735218574;4345.869623911288;4347.652187824967;4348.260795664744;4349.26062569364;4390.47314322277;4459.152760975404;4540.750258735735;4605.976970115128;4654.371659825948;4657.534246575316;4701.341812146371;4702.247640377592;4708.105459962596;4710.128626204163;4773.116973359801;4910.558049775537;5055.646104772631;5062.215356619729;5066.219248257603;5118;4679.368285281444;4724.503927087606;4729.668923175344;4767.6662633615315;4771.880702982315;4885.7801398937845;4887.682300650446;4890.706557606555;4898.21628539432;4941.456439791692;4958.330625365529;4971.925421118758;4982.128127577732;4990.226514890198;5017.172166592617;4857.198562237191;4863.367762190893;4883.780229889735;4913.48408417111;4941.50584941503;4877.219644856806;4882.36529251195;4884.072026314989;4887.413510378778;4922.901541969212;4676.672632915664;4809.134355815987;4846.466888642176;4872.829450969199;4931.48219436954;4912.410510738734;4942.036302920896;4943.332650092191;4977.203647416396;4993.076280888047;4809.951900480951;4830.106430310404;4842.58837998774;4848.515148485123;4889.242167464049 09:44:06 INFO - PROCESS | 4562 | |1;ext.html;505.7319620601083;543.0415316965557;548.0764911124753;564.6273459516717;580.4195804195804;26593.867030664846;26975.5953660695;27003;33808.83095584519;34575.4813677795;37470.875873723766;37999.81000095003;38013.61986380135;38061.238775224476;38096.42855357172;7565.35694465971;7783;7785.688572457095;7790.8441831163345;7791.181925897784;7798;7923.484973476734;7945.801354966143;7946.16565260648;7948.324392426622;7933.642986065641;8005.159458256887;8007.279344858962;8008.519488830689;8017.839643207132;7893.605319734019;7963.124056353797;7969.641366138538;7969.681212751483;7970.681172753083;7797.142314345418;7935.880961785578;7936.6825326986855;7937.047554293464;7942.801429964297;38051;38534.61465385338;38570.22859542821;38580.61419385798;38585.61414385848;3090.7836451448406;3194.9361012779846;3212.068500134958;3225.4033003894356;3329.583802024747;28669.56995645067;28905.855470722723;29905.551416728766;29928.251793705113;30507.69492305071;3424.229548351601;3427.2288735034667;3469.5316132322064;3499.9475007874903;3571.6964058055096;234316;235772;236384;237385.99999999828;237389;50521.74739126281;50775;50851;50933.49066509362;50945.23582146271;62372;63342.36657633457;63393.683031584544;63467.6826615864;63632;14534.345954432076;14881.404743810343;14882.181480018486;14890.702185956221;14895.47865824691;10977.506012229469;11005.17461190414;11042.834357484644;11054.170937179744;11057.225994180491;19909;20491.897540512204;20577.38267851937;20594.27920022822;20678.896605516875;7415;7492.662830172655;7560.130584982688;7624.961875190699;7753.457257991887;852.1308265569209;853.7353420439683;884.7699598104539;949.4113649537331;994.3834822410007;24553.754462455505;25530.10644627429;26313.34216644561;26633.866830665724;27068.1879543614;988.3081842710131;1035.6582327831798;1036.0727149201423;1065.9786804263872;1110.4947249001684;13798.862011379959;14116.858831411555;14373.92813035949;14401.423943042371;14444.133351998913;341064;346097;346466;346823;347606;49844.75077624661;50327.496725033016;50379.49620503822;50458;50488;1083.7290677330668;1160.762043781006;1161.8605767307977;1255.491525931999;1286.8713128687243;26619.866900665373;28040;28407.28981775472;28530.85734571314;28790.42419151647;37111.81444092762;37926;38112.428313575874;38171;38805.41791873068;216227;217429;218466;219214;219278;27107.322316942234;30763.692363076083;31847.203819904687;31860.362792743552;32319.838400807846;34425;34435.65564344324;34441.31117377588;34693.653063470054;35011.47482787709;31689.408157068152;33028.33943321168;33512.83243583766;33961.320773583895;34202.31595368128;33113.66886331202;33442.66557334493;33527.66472335343;33627.49558756572;33809.15477113092;28730.856345718974;31318.373632526767;33856;34017;34176.65823341735;26166.73833261719;27042.594361084994;28066.579001315404;28293.57559636566;28669.139925802257;21954.45113872166;22099.56331877729;23635.527289454458;23668.881655591613;23933.521329573658 09:44:06 INFO - PROCESS | 4562 | |2;jquery.html;349.88453810242623;357.4833174451859;358.25482995369634;361.3044888589465;363.9636036396359;15174.544763657093;15621.218939053044;16802.579935501617;17234.569135771613;17331.48005559832;14687.33906974186;14883.92558037211;14885.702285954274;14959.92520037401;15127.697446051072;4883.096627123976;4889.144399730042;5028.346314979048;5028.723420211887;5049.77276022578;5011.649184557083;5032.622553308516;5039.44566097729;5042.0168067226905;5062.341895553573;4946.431160416562;4990.176620857573;4996;4996.350474438318;5000.924986125211;4670.252759558472;4991.126552853272;5009.524095210949;5021.07110184617;5021.447640759514;4459.710118842265;4460.687751857371;4472.731636101845;4483.663725220622;4490.169318676023;18719.157637906326;19561;19725.21099156032;19773.209071637262;19785.505362366057;1954.540682939508;1959.2848610257297;1975.4863735428748;1980.9306674266475;2002.569447568765;12539.31033793141;12582.81125783114;12719.809202861872;12746.872531274661;12975.67560810978;1718.5274049636325;1739.7216445368806;1792.336835370921;1812.2298023340027;1812.9274829006956;39434;41544.792276038424;48235.99999999965;57315.42684573184;58559.41440585582;9189.8645609476;9244.214241789388;9370.95314523423;9398.577064032135;9473.100055494717;10848.728781780519;11672.241304315192;12021.398930053463;12062.698432539257;12135.150539462153;7030.648467576703;7088;7092.574445533284;7175.533590316612;7261.818454538573;6897.827554311182;6945.062416573799;7035.261297563785;7082.150141982995;7111.715531378791;5486.064955248923;5493.176023596413;5495;5507.476789704971;5638.915416268759;1721.6298495823457;1723.7759091318048;1739.4346837277683;1748.6065635232226;1749.6500699860078;935.7192842147329;956.8995255498212;977.5942983661843;987.6641941739842;997.3915911294105;16205.108719020567;16642.251098700344;16652.91673541649;16693.248803803614;17067;917.1012407840353;922.1976880114344;931.5575101826578;932.8227636748996;939.4316438554577;9371.297152713574;9766.706998790047;9807.754806129904;9973.62078266594;9995.500224988722;387361;392409;394186;399008;404233;67945.66027169832;69573;71337.6433117831;71656.64171679213;72202.27797722061;956.3879117364892;970.2432102959702;978.7650963768644;998.6005597760953;1000.5097502223858;14613.41546338177;14664.560063198121;14734.557963261119;14908.776368354267;14953.177575233467;22525.887370563698;31410.685893140777;31804.363912722078;33074;33156.33687326288;35140.12149696278;35799.46300805438;38431;38658.026298788245;38745.418818717175;7106.324899134574;7195.748148814766;7247.782566523013;7367.963160184379;7369.226231245856;8060.516369017878;9155.542222888962;10898.891011089787;10975.725606859893;11770.76458470843;10021.39871607706;10295;10303.330283531546;10401.84397234027;10486.685399438029;10000.699979000641;10088.243381746544;10247.48762561854;10255.84616230772;10553.841692374466;9128.680496182602;9657.517124143624;10298.948505257425;10495.632652857113;10543.42011189392;6740.157480314961;6848.1097457330225;6866.793996180123;7137.464690148364;7182;7797.220277972157;9013.098690130935;9105.544722763703;9178;9351.111644393772 09:44:06 INFO - PROCESS | 4562 | |3;mootools.html;1306.3468265867066;1398.2868736944156;1399.4332295420352;1529.2735950423544;1726.844583987441;7163.820904477384;7355.043844300247;7361.5583065016135;7366.889496657548;7375.409967202624;7276;7420.4805663603565;7422.4062075034;7440.516366436178;7440.962795186017;1926.364299781069;2181.2801775414155;2200.7579166291694;2215.069670738294;2229.052652622637;2208.8232941364654;2232.754397016335;2233.05095334483;2239.1715065425815;2239.2274665240466;2122.490602255463;2190.211523851412;2190.87950162741;2205.845590808644;2206.977930220701;2189.452636840798;2217.5343177932655;2223.899924503401;2231.319447568491;2233.9776602233933;2208.4920468292385;2222.8999695013604;2235.172985995176;2235.48583825721;2238.507528343762;7472.887906681404;7542.8114297142465;7544;7553.660085296175;7564;4548.090381923628;4631.513691062457;4647.88380290492;4656.767161641905;4657.906841863144;3049.313904371521;3142.355817057498;3154.668759780213;3167.2715275486767;3211.5182722591567;968.2302569457298;980.4950450517989;985.0445068283825;1025.9897401026044;1054.1672079057535;9795.559199836025;9837.360571562896;9847.556859941391;9868.950655246677;9894.10953014225;3882.8446862125197;4011.8194681239415;4040.252553277653;4066.674666026711;4067.08490589615;8002.79993000168;8003.959980200062;8087.919120808834;8107.675692972333;8118.634661440249;4025.677945764332;4581.65637577183;4587.954120458753;4597.747123908217;4598.540145985375;4057.6753859691153;4123.814428350732;4135.710500264952;4145.875623731293;4171.0823618803815;3341.682540158681;3389.6440873708398;3434.10713214561;3445.6898879101;3454.809985450774;1048.0410424461531;1061.103367654331;1061.4374381577777;1064.0370464729433;1075.6127793994156;1209.0448545649015;1210.8365370675021;1231.987680123205;1250.7310928150491;1265.2155663488695;6927.653617319113;7034.909589013711;7109.75115870942;7138.39323657495;7171.067761191116;462.79174371532946;465.98835029123865;468.5197672385832;472.81323877068365;473.3727810650901;5511.503964643121;5523;5572.58205634579;5575.9163612545035;5578.2748242728185;8895.777605559784;9122.133397327243;9275.443473391619;9417.387869788441;9442.95278523603;9189.081091890757;9207.539623018822;9285.117913798178;9349.111834375723;9354.532273386303;6824.249332573512;7188.424926006011;7212.855742885218;7218.494705370678;7224.638768061681;6805.149356330458;6822.215445223665;6833.3166683331265;6856.485763567852;6862.279460656759;8096.947396838609;8318.500889946623;8332.708355207538;8357.331413487029;8453.66185352579;8405.579721013803;8601.913980860112;8606.956965215133;8712.303015758851;8737.956310218407;6140.3552626975315;6250.843728906631;6364;6561.671916404065;6564.573302735307;7002.4398048157045;7036.964815175891;7039.648017599202;7050.330218629222;7072.646367681698;6263.530235232467;6418.903716444163;6427.517936154713;6446.323136070645;6494.058361537645;6095.177151084724;6155.938440615716;6165.969170154121;6183.041628547582;6275.278342990615;6869.622170780655;6879.071325371011;6917.377436030782;6923.238443771081;6929.064576282339;6216.471599913877;6270.184875966095;6296.024116261803;6324.905126423199;6345.650989195454;6271.278802937721;6346.01636746305;6409.134766806422;6414.679266036773;6417.839554011187 09:44:06 INFO - PROCESS | 4562 | |4;prototype.html;306.3780525533167;307.9245584831716;308.1587266761741;314.641308907845;318.1315010022637;5269.2886460327845;5287.39194992576;5298.258243845865;5318.813841515543;5344.251804747339;5246.947530524703;5278.630495865282;5313.654612450188;5343.465653434655;5346;3954.268460334833;4056.127932494513;4101.302778527657;4121.423000779893;4194.790260486979;4162;4170.103427763031;4179.185058913513;4200.663946884257;4201.222773786844;4146.232946904817;4148.3777433385085;4149.605787450202;4150.522689890656;4164.479440069991;3964.2864284428792;4050.06848424861;4103.322951712994;4157.189348077126;4159.9376009359885;3659.2681463707363;3661.743677942545;3665.9083522911874;3666.5966743658178;3668.266346730638;5086.720230387327;5109.744512774347;5126.077306084903;5135.075686376451;5136.845894623168;4776.235802271654;4784.258439941815;4788.186008378584;4789.066132104241;4797.496262892416;5604.915926261109;5610.214569960209;5614.887702245973;5615.157726341082;5618.297712785902;3995.220931918277;4008.7394319369146;4011.29802284599;4015.9196816063513;4020.2763502569524;5685.516731077863;5863.4722874941035;5951.434613711691;5954.1664167016215;5959.195508606326;3897.337452633059;3922.3528117860806;3923.43110249018;3923.725339226227;3927.3323534999117;3979.4030895365927;3980.482537270136;3983.203359328146;3985.242803867314;3988.4017397390044;4621.815127394933;4621.907561848811;4630.143423466669;4639.814407423665;4639.953600463952;5665.348484924287;5665.603407761417;5667;5668.659880407189;5675.517581005661;1426.208454307869;1476.7268055409784;1478.0466599043557;1478.7486127358159;1480.067557438828;910.421882104855;952.9565126186815;982.6315131825565;999.5302207962246;1004.708634495988;4874.098291816025;4884;4895.265710143436;4901.779419926041;4905.975470122627;5766.567507436959;5798.94201057984;5806.2451881255165;5815.73829177688;5815.912761308584;4852.398708426282;4885.5358740919555;4901.313816065754;4902.852914412573;4908.607311415079;3078.399712056172;3116.189790654401;3121.781475296753;3122.250659841667;3127.390158918989;5378.542823859937;5395.595330350161;5398.973005134949;5402.648827826179;5408.8377348679605;5720.885582288331;5850;5897.085951677411;5908.822735317947;5918.082697181943;5343;5348.064088784447;5359.624826262202;5372.167314066326;5376.327959005124;5710.714464276853;5724.255846739898;5729.398413166724;5732.197492351158;5735.483806457439;5637.605367624391;5647.604667673223;5670.461306175906;5674.971625141848;5678.971605141948;5339.599530035185;5358.249845021778;5364.570834333322;5376.327959005124;5379.973100134474;3841.5774264831407;4003.599640035973;4012.077222238843;4014.4580481634607;4144.0261538539025;5809.76760929575;5815.563832712648;5837.591368604157;5839.240898683144;5890.145928840208;5642.153676948491;5649.350324712711;5653.858653533694;5656.462636049569;5657.547396208376;5600;5604.551635869202;5610.887782244414;5675.347335056521;5705.286839145107;5553.777848886161;5565.220869078251;5565.276514053309;5568.1091025435735;5575.135853942483;5499.092649712753;5642.915356269577;5643.943560564342;5654.886902261849;5741.91387129185;5549.500544950974;5585.609007369445;5595.608307418442;5596.916046259228;5597.412271711574 09:44:06 INFO - PROCESS | 4562 | |5;yui.html;651.280335229571;685.5167107189432;717.6053170756086;728.5956294256686;740.4261697184683;12004.699882502942;12117.091218158652;12129;12168.209066410689;13884.791728124086;13825.930870345634;13828.861711382882;13910.652233694163;13913.860861391384;13925.930370348135;652.403051208144;797.8643630582815;813.0812182234097;820.6963423533301;820.9466384684977;803.048387660624;806.0327606871748;811.059171361221;816.1226681317578;816.1756625807947;843.527624530262;844.1684940333766;844.9788755281137;845.4589062999685;845.5560830563973;671.5131529640996;834.3283656656389;838.8657814749672;841.0412130171609;841.1252297610478;613.5643692977991;615.0436071908181;615.5567991046439;615.7044618583105;615.7937091074496;12337.814932776015;12431.689207769878;12493.125481216319;12494.562690305887;12515.436805343781;11586.188966772244;11716.414179291001;11798.587049453228;11979.28124312544;12229.633111006595;9578.808423831553;9832.31173817833;9848.90151098487;9895.356801807931;10457.267991240617;3301.108700650811;3359.81521016344;3386.204242003127;3405.6934875861043;3432.7253819694365;43238.567614323765;43564.78217608892;43858.56141438577;44178.116437671386;44200;9021.32340074497;9395.671151509665;9403.6708715196;9410.43537387759;9412.294077944181;16431.671366572602;16433.260503277383;16565.83434165667;16592.336306547604;16592.917035414746;6778.864422711518;6809.659517024129;6875.621840798804;6972.755953541602;7098;3874.9612503875164;3891.5330160380936;3900.6489415952133;3934.3311637021775;3971.4709836713073;2901.50674385355;2946;2953.42408230393;2955.748761355309;2958.304798372381;526.7418964707342;544.8719550905613;559.5914982063117;567.545963229423;577.5120023580068;581.2501872584403;599.5772980049055;605.9617542246772;659.8548319369827;668.6055227415848;7539.472236943361;7673.939484200948;7877.487963282369;8201.671933122727;8341.374396920255;553.7231384307846;593.0007936626797;631.8420394901275;633.173708310659;637.4677144584232;3734.2531493701367;3847;3861.131245469747;3867.8066096695616;3949.842006319715;46309.073818523444;46712.53287467082;46755;46980.53019469762;47010;43546.346804797955;43601.78199108984;44200.77899610481;44602.77698611486;44757.10485790266;38306.99999999944;38935.415968759924;39033.21933561313;39231.21537569233;40566;7391.8152046199275;7693.115291741521;7780.766577002699;7895.960520197362;7913.287804097658;29409.85295073511;29513.409731805674;30080;30369.696303036686;30372.84813575918;35442.113947150494;37235.6276437243;37582.8120859394;37932.2413551733;37983.240335193696;9965.601375944882;10046.547905344423;10099.798004040025;10280.640177593748;10393.896061039293;10613.575456981944;11272.267302625303;11282.435878205893;11316.660500185008;11406.258593191416;10704.839427408751;10954.780904381709;11057.944710276397;11221.158413118885;11509.309441433541;9824.901750982399;10281.434521101412;10617.097546708615;10843.837342440027;11363.772724545297;10518.474076296308;10550.577976880839;10629.20280978945;10824.783504330027;11027.669169924915;9329.953350233205;9412.811743765224;9595.760105997406;9631.71104866855;9903.059209375098;9184.610165432729;9193.218576420812;9495.66765163216;9596.136347728738;9736.367136136128 09:44:06 INFO - PROCESS | 4562 | __end_tp_report 09:44:06 INFO - PROCESS | 4562 | __start_cc_report 09:44:06 INFO - PROCESS | 4562 | _x_x_mozilla_cycle_collect,849 09:44:06 INFO - PROCESS | 4562 | __end_cc_report 09:44:06 INFO - PROCESS | 4562 | __startTimestamp1459183446338__endTimestamp 09:44:06 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | ------- Summary: start ------- 09:44:06 INFO - PROCESS | 4562 | Number of tests: 6 09:44:06 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | [#0] dojo.html Cycles:165 Average:4651.21 Median:4767.67 stddev:479.42 (10.1%) stddev-sans-first:453.01 09:44:06 INFO - PROCESS | 4562 | Values: 2597.2 2674.7 2679.6 2701.4 2704.4 4653.0 4702.6 4738.2 4743.4 4743.7 4630.9 4688.1 4689.9 4743.1 4769.4 4304.9 4345.9 4355.7 4379.0 4448.2 4371.8 4429.0 4461.2 4463.2 4472.9 4220.1 4287.2 4295.8 4357.7 4366.5 4288.7 4303.5 4304.3 4307.1 4315.9 4282.6 4284.9 4290.8 4291.0 4294.7 4582.9 4634.7 4637.0 4678.4 4726.6 5016.4 5042.9 5045.5 5088.3 5092.1 4896.4 5024.8 5056.6 5059.9 5074.1 4684.3 4686.3 4715.0 4725.6 4733.0 5059.3 5101.9 5110.3 5113.9 5117.6 4913.4 4917.2 4946.4 4964.0 5033.7 5038.4 5057.3 5059.4 5063.1 5089.1 5034.1 5034.4 5036.0 5040.1 5068.1 4871.2 4982.9 4997.4 5047.4 5058.2 4242.0 4257.4 4264.9 4266.4 4309.7 3730.3 3748.3 3748.5 3749.6 3769.5 4190.3 4223.9 4273.9 4290.2 4294.8 5079.2 5083.9 5085.8 5113.7 5146.6 4345.9 4347.7 4348.3 4349.3 4390.5 4459.2 4540.8 4606.0 4654.4 4657.5 4701.3 4702.2 4708.1 4710.1 4773.1 4910.6 5055.6 5062.2 5066.2 5118.0 4679.4 4724.5 4729.7 4767.7 4771.9 4885.8 4887.7 4890.7 4898.2 4941.5 4958.3 4971.9 4982.1 4990.2 5017.2 4857.2 4863.4 4883.8 4913.5 4941.5 4877.2 4882.4 4884.1 4887.4 4922.9 4676.7 4809.1 4846.5 4872.8 4931.5 4912.4 4942.0 4943.3 4977.2 4993.1 4810.0 4830.1 4842.6 4848.5 4889.2 09:44:06 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | [#1] ext.html Cycles:180 Average:42374.88 Median:187540.50 stddev:71498.74 (38.1%) stddev-sans-first:71630.21 09:44:06 INFO - PROCESS | 4562 | Values: 505.7 543.0 548.1 564.6 580.4 26593.9 26975.6 27003.0 33808.8 34575.5 37470.9 37999.8 38013.6 38061.2 38096.4 7565.4 7783.0 7785.7 7790.8 7791.2 7798.0 7923.5 7945.8 7946.2 7948.3 7933.6 8005.2 8007.3 8008.5 8017.8 7893.6 7963.1 7969.6 7969.7 7970.7 7797.1 7935.9 7936.7 7937.0 7942.8 38051.0 38534.6 38570.2 38580.6 38585.6 3090.8 3194.9 3212.1 3225.4 3329.6 28669.6 28905.9 29905.6 29928.3 30507.7 3424.2 3427.2 3469.5 3499.9 3571.7 234316.0 235772.0 236384.0 237386.0 237389.0 50521.7 50775.0 50851.0 50933.5 50945.2 62372.0 63342.4 63393.7 63467.7 63632.0 14534.3 14881.4 14882.2 14890.7 14895.5 10977.5 11005.2 11042.8 11054.2 11057.2 19909.0 20491.9 20577.4 20594.3 20678.9 7415.0 7492.7 7560.1 7625.0 7753.5 852.1 853.7 884.8 949.4 994.4 24553.8 25530.1 26313.3 26633.9 27068.2 988.3 1035.7 1036.1 1066.0 1110.5 13798.9 14116.9 14373.9 14401.4 14444.1 341064.0 346097.0 346466.0 346823.0 347606.0 49844.8 50327.5 50379.5 50458.0 50488.0 1083.7 1160.8 1161.9 1255.5 1286.9 26619.9 28040.0 28407.3 28530.9 28790.4 37111.8 37926.0 38112.4 38171.0 38805.4 216227.0 217429.0 218466.0 219214.0 219278.0 27107.3 30763.7 31847.2 31860.4 32319.8 34425.0 34435.7 34441.3 34693.7 35011.5 31689.4 33028.3 33512.8 33961.3 34202.3 33113.7 33442.7 33527.7 33627.5 33809.2 28730.9 31318.4 33856.0 34017.0 34176.7 26166.7 27042.6 28066.6 28293.6 28669.1 21954.5 22099.6 23635.5 23668.9 23933.5 09:44:06 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | [#2] jquery.html Cycles:180 Average:22923.57 Median:4466.71 stddev:64725.78 (1449.1%) stddev-sans-first:64885.16 09:44:06 INFO - PROCESS | 4562 | Values: 349.9 357.5 358.3 361.3 364.0 15174.5 15621.2 16802.6 17234.6 17331.5 14687.3 14883.9 14885.7 14959.9 15127.7 4883.1 4889.1 5028.3 5028.7 5049.8 5011.6 5032.6 5039.4 5042.0 5062.3 4946.4 4990.2 4996.0 4996.4 5000.9 4670.3 4991.1 5009.5 5021.1 5021.4 4459.7 4460.7 4472.7 4483.7 4490.2 18719.2 19561.0 19725.2 19773.2 19785.5 1954.5 1959.3 1975.5 1980.9 2002.6 12539.3 12582.8 12719.8 12746.9 12975.7 1718.5 1739.7 1792.3 1812.2 1812.9 39434.0 41544.8 48236.0 57315.4 58559.4 9189.9 9244.2 9371.0 9398.6 9473.1 10848.7 11672.2 12021.4 12062.7 12135.2 7030.6 7088.0 7092.6 7175.5 7261.8 6897.8 6945.1 7035.3 7082.2 7111.7 5486.1 5493.2 5495.0 5507.5 5638.9 1721.6 1723.8 1739.4 1748.6 1749.7 935.7 956.9 977.6 987.7 997.4 16205.1 16642.3 16652.9 16693.2 17067.0 917.1 922.2 931.6 932.8 939.4 9371.3 9766.7 9807.8 9973.6 9995.5 387361.0 392409.0 394186.0 399008.0 404233.0 67945.7 69573.0 71337.6 71656.6 72202.3 956.4 970.2 978.8 998.6 1000.5 14613.4 14664.6 14734.6 14908.8 14953.2 22525.9 31410.7 31804.4 33074.0 33156.3 35140.1 35799.5 38431.0 38658.0 38745.4 7106.3 7195.7 7247.8 7368.0 7369.2 8060.5 9155.5 10898.9 10975.7 11770.8 10021.4 10295.0 10303.3 10401.8 10486.7 10000.7 10088.2 10247.5 10255.8 10553.8 9128.7 9657.5 10298.9 10495.6 10543.4 6740.2 6848.1 6866.8 7137.5 7182.0 7797.2 9013.1 9105.5 9178.0 9351.1 09:44:06 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | [#3] mootools.html Cycles:180 Average:5217.45 Median:6270.73 stddev:2717.12 (43.3%) stddev-sans-first:2708.83 09:44:06 INFO - PROCESS | 4562 | Values: 1306.3 1398.3 1399.4 1529.3 1726.8 7163.8 7355.0 7361.6 7366.9 7375.4 7276.0 7420.5 7422.4 7440.5 7441.0 1926.4 2181.3 2200.8 2215.1 2229.1 2208.8 2232.8 2233.1 2239.2 2239.2 2122.5 2190.2 2190.9 2205.8 2207.0 2189.5 2217.5 2223.9 2231.3 2234.0 2208.5 2222.9 2235.2 2235.5 2238.5 7472.9 7542.8 7544.0 7553.7 7564.0 4548.1 4631.5 4647.9 4656.8 4657.9 3049.3 3142.4 3154.7 3167.3 3211.5 968.2 980.5 985.0 1026.0 1054.2 9795.6 9837.4 9847.6 9869.0 9894.1 3882.8 4011.8 4040.3 4066.7 4067.1 8002.8 8004.0 8087.9 8107.7 8118.6 4025.7 4581.7 4588.0 4597.7 4598.5 4057.7 4123.8 4135.7 4145.9 4171.1 3341.7 3389.6 3434.1 3445.7 3454.8 1048.0 1061.1 1061.4 1064.0 1075.6 1209.0 1210.8 1232.0 1250.7 1265.2 6927.7 7034.9 7109.8 7138.4 7171.1 462.8 466.0 468.5 472.8 473.4 5511.5 5523.0 5572.6 5575.9 5578.3 8895.8 9122.1 9275.4 9417.4 9443.0 9189.1 9207.5 9285.1 9349.1 9354.5 6824.2 7188.4 7212.9 7218.5 7224.6 6805.1 6822.2 6833.3 6856.5 6862.3 8096.9 8318.5 8332.7 8357.3 8453.7 8405.6 8601.9 8607.0 8712.3 8738.0 6140.4 6250.8 6364.0 6561.7 6564.6 7002.4 7037.0 7039.6 7050.3 7072.6 6263.5 6418.9 6427.5 6446.3 6494.1 6095.2 6155.9 6166.0 6183.0 6275.3 6869.6 6879.1 6917.4 6923.2 6929.1 6216.5 6270.2 6296.0 6324.9 6345.7 6271.3 6346.0 6409.1 6414.7 6417.8 09:44:06 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | [#4] prototype.html Cycles:180 Average:4642.41 Median:5305.96 stddev:1358.85 (25.6%) stddev-sans-first:1323.11 09:44:06 INFO - PROCESS | 4562 | Values: 306.4 307.9 308.2 314.6 318.1 5269.3 5287.4 5298.3 5318.8 5344.3 5246.9 5278.6 5313.7 5343.5 5346.0 3954.3 4056.1 4101.3 4121.4 4194.8 4162.0 4170.1 4179.2 4200.7 4201.2 4146.2 4148.4 4149.6 4150.5 4164.5 3964.3 4050.1 4103.3 4157.2 4159.9 3659.3 3661.7 3665.9 3666.6 3668.3 5086.7 5109.7 5126.1 5135.1 5136.8 4776.2 4784.3 4788.2 4789.1 4797.5 5604.9 5610.2 5614.9 5615.2 5618.3 3995.2 4008.7 4011.3 4015.9 4020.3 5685.5 5863.5 5951.4 5954.2 5959.2 3897.3 3922.4 3923.4 3923.7 3927.3 3979.4 3980.5 3983.2 3985.2 3988.4 4621.8 4621.9 4630.1 4639.8 4640.0 5665.3 5665.6 5667.0 5668.7 5675.5 1426.2 1476.7 1478.0 1478.7 1480.1 910.4 953.0 982.6 999.5 1004.7 4874.1 4884.0 4895.3 4901.8 4906.0 5766.6 5798.9 5806.2 5815.7 5815.9 4852.4 4885.5 4901.3 4902.9 4908.6 3078.4 3116.2 3121.8 3122.3 3127.4 5378.5 5395.6 5399.0 5402.6 5408.8 5720.9 5850.0 5897.1 5908.8 5918.1 5343.0 5348.1 5359.6 5372.2 5376.3 5710.7 5724.3 5729.4 5732.2 5735.5 5637.6 5647.6 5670.5 5675.0 5679.0 5339.6 5358.2 5364.6 5376.3 5380.0 3841.6 4003.6 4012.1 4014.5 4144.0 5809.8 5815.6 5837.6 5839.2 5890.1 5642.2 5649.4 5653.9 5656.5 5657.5 5600.0 5604.6 5610.9 5675.3 5705.3 5553.8 5565.2 5565.3 5568.1 5575.1 5499.1 5642.9 5643.9 5654.9 5741.9 5549.5 5585.6 5595.6 5596.9 5597.4 09:44:06 INFO - PROCESS | 4562 | 09:44:06 INFO - PROCESS | 4562 | [#5] yui.html Cycles:180 Average:12313.26 Median:44200.39 stddev:13480.92 (30.5%) stddev-sans-first:13490.29 09:44:06 INFO - PROCESS | 4562 | Values: 651.3 685.5 717.6 728.6 740.4 12004.7 12117.1 12129.0 12168.2 13884.8 13825.9 13828.9 13910.7 13913.9 13925.9 652.4 797.9 813.1 820.7 820.9 803.0 806.0 811.1 816.1 816.2 843.5 844.2 845.0 845.5 845.6 671.5 834.3 838.9 841.0 841.1 613.6 615.0 615.6 615.7 615.8 12337.8 12431.7 12493.1 12494.6 12515.4 11586.2 11716.4 11798.6 11979.3 12229.6 9578.8 9832.3 9848.9 9895.4 10457.3 3301.1 3359.8 3386.2 3405.7 3432.7 43238.6 43564.8 43858.6 44178.1 44200.0 9021.3 9395.7 9403.7 9410.4 9412.3 16431.7 16433.3 16565.8 16592.3 16592.9 6778.9 6809.7 6875.6 6972.8 7098.0 3875.0 3891.5 3900.6 3934.3 3971.5 2901.5 2946.0 2953.4 2955.7 2958.3 526.7 544.9 559.6 567.5 577.5 581.3 599.6 606.0 659.9 668.6 7539.5 7673.9 7877.5 8201.7 8341.4 553.7 593.0 631.8 633.2 637.5 3734.3 3847.0 3861.1 3867.8 3949.8 46309.1 46712.5 46755.0 46980.5 47010.0 43546.3 43601.8 44200.8 44602.8 44757.1 38307.0 38935.4 39033.2 39231.2 40566.0 7391.8 7693.1 7780.8 7896.0 7913.3 29409.9 29513.4 30080.0 30369.7 30372.8 35442.1 37235.6 37582.8 37932.2 37983.2 9965.6 10046.5 10099.8 10280.6 10393.9 10613.6 11272.3 11282.4 11316.7 11406.3 10704.8 10954.8 11057.9 11221.2 11509.3 9824.9 10281.4 10617.1 10843.8 11363.8 10518.5 10550.6 10629.2 10824.8 11027.7 9330.0 9412.8 9595.8 9631.7 9903.1 9184.6 9193.2 9495.7 9596.1 9736.4 09:44:06 INFO - PROCESS | 4562 | -------- Summary: end -------- 09:44:06 INFO - PROCESS | 4562 | 09:44:07 INFO - TEST-INFO | 4562: exit 0 09:44:07 INFO - TEST-OK | dromaeo_css | took 1117581ms 09:44:07 INFO - TEST-START | kraken 09:44:07 INFO - operating with platform_type : linux_ 09:44:07 INFO - Initialising browser for kraken test... 09:44:07 INFO - TEST-INFO | started process 4745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUjWdm2/profile http://localhost:37391/getInfo.html) 09:44:11 INFO - PROCESS | 4745 | __metrics Screen width/height:1600/1200 09:44:11 INFO - PROCESS | 4745 | colorDepth:24 09:44:11 INFO - PROCESS | 4745 | Browser inner width/height: 1024/697 09:44:11 INFO - PROCESS | 4745 | __metrics 09:44:12 ERROR - PROCESS | 4745 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:44:12 INFO - PROCESS | 4745 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:44:13 INFO - TEST-INFO | 4745: exit 0 09:44:13 INFO - Browser initialized. 09:44:13 INFO - Running cycle 1/1 for kraken test... 09:44:13 INFO - TEST-INFO | started process 4826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUjWdm2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:25 INFO - PROCESS | 4826 | RSS: Main: 154849280 09:44:25 INFO - PROCESS | 4826 | 09:44:28 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37391/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:28 INFO - PROCESS | 4826 | RSS: Main: 195002368 09:44:28 INFO - PROCESS | 4826 | 09:44:31 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37391/tests/kraken/driver.html?testName=audio-dft) 09:44:32 INFO - PROCESS | 4826 | RSS: Main: 185880576 09:44:32 INFO - PROCESS | 4826 | 09:44:35 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37391/tests/kraken/driver.html?testName=audio-fft) 09:44:35 INFO - PROCESS | 4826 | RSS: Main: 171286528 09:44:35 INFO - PROCESS | 4826 | 09:44:37 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37391/tests/kraken/driver.html?testName=audio-oscillator) 09:44:38 INFO - PROCESS | 4826 | RSS: Main: 172556288 09:44:38 INFO - PROCESS | 4826 | 09:44:40 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:41 INFO - PROCESS | 4826 | RSS: Main: 173576192 09:44:41 INFO - PROCESS | 4826 | 09:44:44 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37391/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:44 INFO - PROCESS | 4826 | RSS: Main: 173895680 09:44:44 INFO - PROCESS | 4826 | 09:44:48 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37391/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:48 INFO - PROCESS | 4826 | RSS: Main: 174735360 09:44:48 INFO - PROCESS | 4826 | 09:44:51 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37391/tests/kraken/driver.html?testName=json-parse-financial) 09:44:52 INFO - PROCESS | 4826 | RSS: Main: 175443968 09:44:52 INFO - PROCESS | 4826 | 09:44:53 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:54 INFO - PROCESS | 4826 | RSS: Main: 184336384 09:44:54 INFO - PROCESS | 4826 | 09:44:56 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37391/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:57 INFO - PROCESS | 4826 | RSS: Main: 182816768 09:44:57 INFO - PROCESS | 4826 | 09:44:59 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:59 INFO - PROCESS | 4826 | RSS: Main: 192999424 09:44:59 INFO - PROCESS | 4826 | 09:45:02 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:02 INFO - PROCESS | 4826 | RSS: Main: 195969024 09:45:02 INFO - PROCESS | 4826 | 09:45:05 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:06 INFO - PROCESS | 4826 | RSS: Main: 196063232 09:45:06 INFO - PROCESS | 4826 | 09:45:07 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:37391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37391/tests/kraken/driver.html?testName=ai-astar) 09:45:08 INFO - PROCESS | 4826 | RSS: Main: 258248704 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | __start_tp_report 09:45:08 INFO - PROCESS | 4826 | _x_x_mozilla_page_load 09:45:08 INFO - PROCESS | 4826 | _x_x_mozilla_page_load_details 09:45:08 INFO - PROCESS | 4826 | |i|pagename|runs| 09:45:08 INFO - PROCESS | 4826 | |0;ai-astar;111;112;109;112;113;113;102;111;112;113 09:45:08 INFO - PROCESS | 4826 | |1;audio-beat-detection;153;131;155;184;135;158;156;133;177;137 09:45:08 INFO - PROCESS | 4826 | |2;audio-dft;160;161;160;162;160;163;160;161;162;163 09:45:08 INFO - PROCESS | 4826 | |3;audio-fft;74;74;115;100;74;73;74;119;92;74 09:45:08 INFO - PROCESS | 4826 | |4;audio-oscillator;94;94;135;93;94;94;144;94;93;132 09:45:08 INFO - PROCESS | 4826 | |5;imaging-gaussian-blur;117;116;116;117;118;117;117;116;117;116 09:45:08 INFO - PROCESS | 4826 | |6;imaging-darkroom;146;146;145;146;146;145;146;145;145;145 09:45:08 INFO - PROCESS | 4826 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;97;96 09:45:08 INFO - PROCESS | 4826 | |8;json-parse-financial;65;65;65;66;66;65;64;75;63;63 09:45:08 INFO - PROCESS | 4826 | |9;json-stringify-tinderbox;63;64;63;67;63;64;65;64;64;64 09:45:08 INFO - PROCESS | 4826 | |10;stanford-crypto-aes;82;85;83;83;85;84;84;85;85;82 09:45:08 INFO - PROCESS | 4826 | |11;stanford-crypto-ccm;118;118;118;118;128;116;121;129;118;117 09:45:08 INFO - PROCESS | 4826 | |12;stanford-crypto-pbkdf2;142;142;145;160;144;131;133;141;142;143 09:45:08 INFO - PROCESS | 4826 | |13;stanford-crypto-sha256-iterative;68;71;69;69;70;66;66;65;68;67 09:45:08 INFO - PROCESS | 4826 | __end_tp_report 09:45:08 INFO - PROCESS | 4826 | __start_cc_report 09:45:08 INFO - PROCESS | 4826 | _x_x_mozilla_cycle_collect,1155 09:45:08 INFO - PROCESS | 4826 | __end_cc_report 09:45:08 INFO - PROCESS | 4826 | __startTimestamp1459183508072__endTimestamp 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | ------- Summary: start ------- 09:45:08 INFO - PROCESS | 4826 | Number of tests: 14 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.33 (3.0%) stddev-sans-first:3.53 09:45:08 INFO - PROCESS | 4826 | Values: 111.0 112.0 109.0 112.0 113.0 113.0 102.0 111.0 112.0 113.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:155.50 stddev:18.34 (11.8%) stddev-sans-first:19.45 09:45:08 INFO - PROCESS | 4826 | Values: 153.0 131.0 155.0 184.0 135.0 158.0 156.0 133.0 177.0 137.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.23 (0.8%) stddev-sans-first:1.22 09:45:08 INFO - PROCESS | 4826 | Values: 160.0 161.0 160.0 162.0 160.0 163.0 160.0 161.0 162.0 163.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#3] audio-fft Cycles:10 Average:86.90 Median:74.00 stddev:18.39 (24.8%) stddev-sans-first:18.90 09:45:08 INFO - PROCESS | 4826 | Values: 74.0 74.0 115.0 100.0 74.0 73.0 74.0 119.0 92.0 74.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:94.00 stddev:21.12 (22.5%) stddev-sans-first:21.89 09:45:08 INFO - PROCESS | 4826 | Values: 94.0 94.0 135.0 93.0 94.0 94.0 144.0 94.0 93.0 132.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:45:08 INFO - PROCESS | 4826 | Values: 117.0 116.0 116.0 117.0 118.0 117.0 117.0 116.0 117.0 116.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:45:08 INFO - PROCESS | 4826 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 09:45:08 INFO - PROCESS | 4826 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 97.0 96.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:65.00 stddev:3.43 (5.3%) stddev-sans-first:3.63 09:45:08 INFO - PROCESS | 4826 | Values: 65.0 65.0 65.0 66.0 66.0 65.0 64.0 75.0 63.0 63.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:1.20 (1.9%) stddev-sans-first:1.20 09:45:08 INFO - PROCESS | 4826 | Values: 63.0 64.0 63.0 67.0 63.0 64.0 65.0 64.0 64.0 64.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.50 stddev:1.23 (1.5%) stddev-sans-first:1.12 09:45:08 INFO - PROCESS | 4826 | Values: 82.0 85.0 83.0 83.0 85.0 84.0 84.0 85.0 85.0 82.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:118.00 stddev:4.61 (3.9%) stddev-sans-first:4.82 09:45:08 INFO - PROCESS | 4826 | Values: 118.0 118.0 118.0 118.0 128.0 116.0 121.0 129.0 118.0 117.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:142.50 stddev:7.75 (5.4%) stddev-sans-first:8.22 09:45:08 INFO - PROCESS | 4826 | Values: 142.0 142.0 145.0 160.0 144.0 131.0 133.0 141.0 142.0 143.0 09:45:08 INFO - PROCESS | 4826 | 09:45:08 INFO - PROCESS | 4826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.91 (2.8%) stddev-sans-first:2.03 09:45:08 INFO - PROCESS | 4826 | Values: 68.0 71.0 69.0 69.0 70.0 66.0 66.0 65.0 68.0 67.0 09:45:08 INFO - PROCESS | 4826 | -------- Summary: end -------- 09:45:08 INFO - PROCESS | 4826 | 09:45:09 INFO - TEST-INFO | 4826: exit 0 09:45:09 INFO - TEST-OK | kraken | took 61950ms 09:45:09 INFO - SUITE-END | took 1179s 09:45:09 INFO - Completed test suite (00:19:39) 09:45:09 INFO - javascript benchmark 09:45:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2597.2078516052607, 2674.652295201625, 2679.638248836409, 2701.3921867579797, 2704.377993061595, 4653.0, 4702.6002789762915, 4738.17082010648, 4743.383360163182, 4743.715377077374, 4630.907381852361, 4688.062387522501, 4689.9062018759605, 4743.075100355432, 4769.356136921515, 4304.913901721971, 4345.913081738363, 4355.716878402894, 4379.0366119453665, 4448.177087238855, 4371.846985355513, 4428.955710442887, 4461.241588929874, 4463.196624607569, 4472.865814025568, 4220.134872351161, 4287.249731297011, 4295.78521073945, 4357.716748411375, 4366.541513141122, 4288.656907447396, 4303.483581970152, 4304.311310190355, 4307.138572285524, 4315.892102697427, 4282.635975942048, 4284.9143017139795, 4290.828366865321, 4291.0, 4294.720843145185, 4582.908341833145, 4634.698744581591, 4636.976815115937, 4678.415198100238, 4726.645501587394, 5016.372953380827, 5042.949570504321, 5045.520675535855, 5088.338515992934, 5092.083424983502, 4896.436909755388, 5024.824131155428, 5056.595472362239, 5059.898802023976, 5074.112030394703, 4684.297355396718, 4686.27362758773, 4715.033418149271, 4725.5983241424865, 4732.9763351183365, 5059.316992206079, 5101.8724531886255, 5110.310108135429, 5113.8721531961255, 5117.632190630038, 4913.434954980152, 4917.164082106051, 4946.431160416526, 4964.0, 5033.672811267256, 5038.370203724535, 5057.342545469065, 5059.418166910852, 5063.063333283354, 5089.134847075932, 5034.144195486776, 5034.446210916796, 5035.974820125876, 5040.143175660147, 5068.087744206005, 4871.244957031666, 4982.9252561211615, 4997.350344455271, 5047.369078865142, 5058.1654027085115, 4241.97879010603, 4257.40396344512, 4264.872053838328, 4266.360045993064, 4309.719868208556, 3730.2539492101146, 3748.2878253131817, 3748.456473811282, 3749.6250374962287, 3769.4722738816586, 4190.28765109932, 4223.852165174266, 4273.87178384649, 4290.249206388869, 4294.785260737013, 5079.238114282887, 5083.949160508348, 5085.847424577269, 5113.667611605234, 5146.639735218574, 4345.869623911288, 4347.652187824967, 4348.260795664744, 4349.26062569364, 4390.47314322277, 4459.152760975404, 4540.750258735735, 4605.976970115128, 4654.371659825948, 4657.534246575316, 4701.341812146371, 4702.247640377592, 4708.105459962596, 4710.128626204163, 4773.116973359801, 4910.558049775537, 5055.646104772631, 5062.215356619729, 5066.219248257603, 5118.0, 4679.368285281444, 4724.503927087606, 4729.668923175344, 4767.6662633615315, 4771.880702982315, 4885.7801398937845, 4887.682300650446, 4890.706557606555, 4898.21628539432, 4941.456439791692, 4958.330625365529, 4971.925421118758, 4982.128127577732, 4990.226514890198, 5017.172166592617, 4857.198562237191, 4863.367762190893, 4883.780229889735, 4913.48408417111, 4941.50584941503, 4877.219644856806, 4882.36529251195, 4884.072026314989, 4887.413510378778, 4922.901541969212, 4676.672632915664, 4809.134355815987, 4846.466888642176, 4872.829450969199, 4931.48219436954, 4912.410510738734, 4942.036302920896, 4943.332650092191, 4977.203647416396, 4993.076280888047, 4809.951900480951, 4830.106430310404, 4842.58837998774, 4848.515148485123, 4889.242167464049], "unit": "score", "name": "dojo.html", "value": 4621.274931713297}, {"lowerIsBetter": false, "replicates": [505.7319620601083, 543.0415316965557, 548.0764911124753, 564.6273459516717, 580.4195804195804, 26593.867030664846, 26975.5953660695, 27003.0, 33808.83095584519, 34575.4813677795, 37470.875873723766, 37999.81000095003, 38013.61986380135, 38061.238775224476, 38096.42855357172, 7565.35694465971, 7783.0, 7785.688572457095, 7790.8441831163345, 7791.181925897784, 7798.0, 7923.484973476734, 7945.801354966143, 7946.16565260648, 7948.324392426622, 7933.642986065641, 8005.159458256887, 8007.279344858962, 8008.519488830689, 8017.839643207132, 7893.605319734019, 7963.124056353797, 7969.641366138538, 7969.681212751483, 7970.681172753083, 7797.142314345418, 7935.880961785578, 7936.6825326986855, 7937.047554293464, 7942.801429964297, 38051.0, 38534.61465385338, 38570.22859542821, 38580.61419385798, 38585.61414385848, 3090.7836451448406, 3194.9361012779846, 3212.068500134958, 3225.4033003894356, 3329.583802024747, 28669.56995645067, 28905.855470722723, 29905.551416728766, 29928.251793705113, 30507.69492305071, 3424.229548351601, 3427.2288735034667, 3469.5316132322064, 3499.9475007874903, 3571.6964058055096, 234316.0, 235772.0, 236384.0, 237385.99999999828, 237389.0, 50521.74739126281, 50775.0, 50851.0, 50933.49066509362, 50945.23582146271, 62372.0, 63342.36657633457, 63393.683031584544, 63467.6826615864, 63632.0, 14534.345954432076, 14881.404743810343, 14882.181480018486, 14890.702185956221, 14895.47865824691, 10977.506012229469, 11005.17461190414, 11042.834357484644, 11054.170937179744, 11057.225994180491, 19909.0, 20491.897540512204, 20577.38267851937, 20594.27920022822, 20678.896605516875, 7415.0, 7492.662830172655, 7560.130584982688, 7624.961875190699, 7753.457257991887, 852.1308265569209, 853.7353420439683, 884.7699598104539, 949.4113649537331, 994.3834822410007, 24553.754462455505, 25530.10644627429, 26313.34216644561, 26633.866830665724, 27068.1879543614, 988.3081842710131, 1035.6582327831798, 1036.0727149201423, 1065.9786804263872, 1110.4947249001684, 13798.862011379959, 14116.858831411555, 14373.92813035949, 14401.423943042371, 14444.133351998913, 341064.0, 346097.0, 346466.0, 346823.0, 347606.0, 49844.75077624661, 50327.496725033016, 50379.49620503822, 50458.0, 50488.0, 1083.7290677330668, 1160.762043781006, 1161.8605767307977, 1255.491525931999, 1286.8713128687243, 26619.866900665373, 28040.0, 28407.28981775472, 28530.85734571314, 28790.42419151647, 37111.81444092762, 37926.0, 38112.428313575874, 38171.0, 38805.41791873068, 216227.0, 217429.0, 218466.0, 219214.0, 219278.0, 27107.322316942234, 30763.692363076083, 31847.203819904687, 31860.362792743552, 32319.838400807846, 34425.0, 34435.65564344324, 34441.31117377588, 34693.653063470054, 35011.47482787709, 31689.408157068152, 33028.33943321168, 33512.83243583766, 33961.320773583895, 34202.31595368128, 33113.66886331202, 33442.66557334493, 33527.66472335343, 33627.49558756572, 33809.15477113092, 28730.856345718974, 31318.373632526767, 33856.0, 34017.0, 34176.65823341735, 26166.73833261719, 27042.594361084994, 28066.579001315404, 28293.57559636566, 28669.139925802257, 21954.45113872166, 22099.56331877729, 23635.527289454458, 23668.881655591613, 23933.521329573658], "unit": "score", "name": "ext.html", "value": 16992.208809464788}, {"lowerIsBetter": false, "replicates": [349.88453810242623, 357.4833174451859, 358.25482995369634, 361.3044888589465, 363.9636036396359, 15174.544763657093, 15621.218939053044, 16802.579935501617, 17234.569135771613, 17331.48005559832, 14687.33906974186, 14883.92558037211, 14885.702285954274, 14959.92520037401, 15127.697446051072, 4883.096627123976, 4889.144399730042, 5028.346314979048, 5028.723420211887, 5049.77276022578, 5011.649184557083, 5032.622553308516, 5039.44566097729, 5042.0168067226905, 5062.341895553573, 4946.431160416562, 4990.176620857573, 4996.0, 4996.350474438318, 5000.924986125211, 4670.252759558472, 4991.126552853272, 5009.524095210949, 5021.07110184617, 5021.447640759514, 4459.710118842265, 4460.687751857371, 4472.731636101845, 4483.663725220622, 4490.169318676023, 18719.157637906326, 19561.0, 19725.21099156032, 19773.209071637262, 19785.505362366057, 1954.540682939508, 1959.2848610257297, 1975.4863735428748, 1980.9306674266475, 2002.569447568765, 12539.31033793141, 12582.81125783114, 12719.809202861872, 12746.872531274661, 12975.67560810978, 1718.5274049636325, 1739.7216445368806, 1792.336835370921, 1812.2298023340027, 1812.9274829006956, 39434.0, 41544.792276038424, 48235.99999999965, 57315.42684573184, 58559.41440585582, 9189.8645609476, 9244.214241789388, 9370.95314523423, 9398.577064032135, 9473.100055494717, 10848.728781780519, 11672.241304315192, 12021.398930053463, 12062.698432539257, 12135.150539462153, 7030.648467576703, 7088.0, 7092.574445533284, 7175.533590316612, 7261.818454538573, 6897.827554311182, 6945.062416573799, 7035.261297563785, 7082.150141982995, 7111.715531378791, 5486.064955248923, 5493.176023596413, 5495.0, 5507.476789704971, 5638.915416268759, 1721.6298495823457, 1723.7759091318048, 1739.4346837277683, 1748.6065635232226, 1749.6500699860078, 935.7192842147329, 956.8995255498212, 977.5942983661843, 987.6641941739842, 997.3915911294105, 16205.108719020567, 16642.251098700344, 16652.91673541649, 16693.248803803614, 17067.0, 917.1012407840353, 922.1976880114344, 931.5575101826578, 932.8227636748996, 939.4316438554577, 9371.297152713574, 9766.706998790047, 9807.754806129904, 9973.62078266594, 9995.500224988722, 387361.0, 392409.0, 394186.0, 399008.0, 404233.0, 67945.66027169832, 69573.0, 71337.6433117831, 71656.64171679213, 72202.27797722061, 956.3879117364892, 970.2432102959702, 978.7650963768644, 998.6005597760953, 1000.5097502223858, 14613.41546338177, 14664.560063198121, 14734.557963261119, 14908.776368354267, 14953.177575233467, 22525.887370563698, 31410.685893140777, 31804.363912722078, 33074.0, 33156.33687326288, 35140.12149696278, 35799.46300805438, 38431.0, 38658.026298788245, 38745.418818717175, 7106.324899134574, 7195.748148814766, 7247.782566523013, 7367.963160184379, 7369.226231245856, 8060.516369017878, 9155.542222888962, 10898.891011089787, 10975.725606859893, 11770.76458470843, 10021.39871607706, 10295.0, 10303.330283531546, 10401.84397234027, 10486.685399438029, 10000.699979000641, 10088.243381746544, 10247.48762561854, 10255.84616230772, 10553.841692374466, 9128.680496182602, 9657.517124143624, 10298.948505257425, 10495.632652857113, 10543.42011189392, 6740.157480314961, 6848.1097457330225, 6866.793996180123, 7137.464690148364, 7182.0, 7797.220277972157, 9013.098690130935, 9105.544722763703, 9178.0, 9351.111644393772], "unit": "score", "name": "jquery.html", "value": 7867.481829573743}, {"lowerIsBetter": false, "replicates": [1306.3468265867066, 1398.2868736944156, 1399.4332295420352, 1529.2735950423544, 1726.844583987441, 7163.820904477384, 7355.043844300247, 7361.5583065016135, 7366.889496657548, 7375.409967202624, 7276.0, 7420.4805663603565, 7422.4062075034, 7440.516366436178, 7440.962795186017, 1926.364299781069, 2181.2801775414155, 2200.7579166291694, 2215.069670738294, 2229.052652622637, 2208.8232941364654, 2232.754397016335, 2233.05095334483, 2239.1715065425815, 2239.2274665240466, 2122.490602255463, 2190.211523851412, 2190.87950162741, 2205.845590808644, 2206.977930220701, 2189.452636840798, 2217.5343177932655, 2223.899924503401, 2231.319447568491, 2233.9776602233933, 2208.4920468292385, 2222.8999695013604, 2235.172985995176, 2235.48583825721, 2238.507528343762, 7472.887906681404, 7542.8114297142465, 7544.0, 7553.660085296175, 7564.0, 4548.090381923628, 4631.513691062457, 4647.88380290492, 4656.767161641905, 4657.906841863144, 3049.313904371521, 3142.355817057498, 3154.668759780213, 3167.2715275486767, 3211.5182722591567, 968.2302569457298, 980.4950450517989, 985.0445068283825, 1025.9897401026044, 1054.1672079057535, 9795.559199836025, 9837.360571562896, 9847.556859941391, 9868.950655246677, 9894.10953014225, 3882.8446862125197, 4011.8194681239415, 4040.252553277653, 4066.674666026711, 4067.08490589615, 8002.79993000168, 8003.959980200062, 8087.919120808834, 8107.675692972333, 8118.634661440249, 4025.677945764332, 4581.65637577183, 4587.954120458753, 4597.747123908217, 4598.540145985375, 4057.6753859691153, 4123.814428350732, 4135.710500264952, 4145.875623731293, 4171.0823618803815, 3341.682540158681, 3389.6440873708398, 3434.10713214561, 3445.6898879101, 3454.809985450774, 1048.0410424461531, 1061.103367654331, 1061.4374381577777, 1064.0370464729433, 1075.6127793994156, 1209.0448545649015, 1210.8365370675021, 1231.987680123205, 1250.7310928150491, 1265.2155663488695, 6927.653617319113, 7034.909589013711, 7109.75115870942, 7138.39323657495, 7171.067761191116, 462.79174371532946, 465.98835029123865, 468.5197672385832, 472.81323877068365, 473.3727810650901, 5511.503964643121, 5523.0, 5572.58205634579, 5575.9163612545035, 5578.2748242728185, 8895.777605559784, 9122.133397327243, 9275.443473391619, 9417.387869788441, 9442.95278523603, 9189.081091890757, 9207.539623018822, 9285.117913798178, 9349.111834375723, 9354.532273386303, 6824.249332573512, 7188.424926006011, 7212.855742885218, 7218.494705370678, 7224.638768061681, 6805.149356330458, 6822.215445223665, 6833.3166683331265, 6856.485763567852, 6862.279460656759, 8096.947396838609, 8318.500889946623, 8332.708355207538, 8357.331413487029, 8453.66185352579, 8405.579721013803, 8601.913980860112, 8606.956965215133, 8712.303015758851, 8737.956310218407, 6140.3552626975315, 6250.843728906631, 6364.0, 6561.671916404065, 6564.573302735307, 7002.4398048157045, 7036.964815175891, 7039.648017599202, 7050.330218629222, 7072.646367681698, 6263.530235232467, 6418.903716444163, 6427.517936154713, 6446.323136070645, 6494.058361537645, 6095.177151084724, 6155.938440615716, 6165.969170154121, 6183.041628547582, 6275.278342990615, 6869.622170780655, 6879.071325371011, 6917.377436030782, 6923.238443771081, 6929.064576282339, 6216.471599913877, 6270.184875966095, 6296.024116261803, 6324.905126423199, 6345.650989195454, 6271.278802937721, 6346.01636746305, 6409.134766806422, 6414.679266036773, 6417.839554011187], "unit": "score", "name": "mootools.html", "value": 4220.274486142117}, {"lowerIsBetter": false, "replicates": [306.3780525533167, 307.9245584831716, 308.1587266761741, 314.641308907845, 318.1315010022637, 5269.2886460327845, 5287.39194992576, 5298.258243845865, 5318.813841515543, 5344.251804747339, 5246.947530524703, 5278.630495865282, 5313.654612450188, 5343.465653434655, 5346.0, 3954.268460334833, 4056.127932494513, 4101.302778527657, 4121.423000779893, 4194.790260486979, 4162.0, 4170.103427763031, 4179.185058913513, 4200.663946884257, 4201.222773786844, 4146.232946904817, 4148.3777433385085, 4149.605787450202, 4150.522689890656, 4164.479440069991, 3964.2864284428792, 4050.06848424861, 4103.322951712994, 4157.189348077126, 4159.9376009359885, 3659.2681463707363, 3661.743677942545, 3665.9083522911874, 3666.5966743658178, 3668.266346730638, 5086.720230387327, 5109.744512774347, 5126.077306084903, 5135.075686376451, 5136.845894623168, 4776.235802271654, 4784.258439941815, 4788.186008378584, 4789.066132104241, 4797.496262892416, 5604.915926261109, 5610.214569960209, 5614.887702245973, 5615.157726341082, 5618.297712785902, 3995.220931918277, 4008.7394319369146, 4011.29802284599, 4015.9196816063513, 4020.2763502569524, 5685.516731077863, 5863.4722874941035, 5951.434613711691, 5954.1664167016215, 5959.195508606326, 3897.337452633059, 3922.3528117860806, 3923.43110249018, 3923.725339226227, 3927.3323534999117, 3979.4030895365927, 3980.482537270136, 3983.203359328146, 3985.242803867314, 3988.4017397390044, 4621.815127394933, 4621.907561848811, 4630.143423466669, 4639.814407423665, 4639.953600463952, 5665.348484924287, 5665.603407761417, 5667.0, 5668.659880407189, 5675.517581005661, 1426.208454307869, 1476.7268055409784, 1478.0466599043557, 1478.7486127358159, 1480.067557438828, 910.421882104855, 952.9565126186815, 982.6315131825565, 999.5302207962246, 1004.708634495988, 4874.098291816025, 4884.0, 4895.265710143436, 4901.779419926041, 4905.975470122627, 5766.567507436959, 5798.94201057984, 5806.2451881255165, 5815.73829177688, 5815.912761308584, 4852.398708426282, 4885.5358740919555, 4901.313816065754, 4902.852914412573, 4908.607311415079, 3078.399712056172, 3116.189790654401, 3121.781475296753, 3122.250659841667, 3127.390158918989, 5378.542823859937, 5395.595330350161, 5398.973005134949, 5402.648827826179, 5408.8377348679605, 5720.885582288331, 5850.0, 5897.085951677411, 5908.822735317947, 5918.082697181943, 5343.0, 5348.064088784447, 5359.624826262202, 5372.167314066326, 5376.327959005124, 5710.714464276853, 5724.255846739898, 5729.398413166724, 5732.197492351158, 5735.483806457439, 5637.605367624391, 5647.604667673223, 5670.461306175906, 5674.971625141848, 5678.971605141948, 5339.599530035185, 5358.249845021778, 5364.570834333322, 5376.327959005124, 5379.973100134474, 3841.5774264831407, 4003.599640035973, 4012.077222238843, 4014.4580481634607, 4144.0261538539025, 5809.76760929575, 5815.563832712648, 5837.591368604157, 5839.240898683144, 5890.145928840208, 5642.153676948491, 5649.350324712711, 5653.858653533694, 5656.462636049569, 5657.547396208376, 5600.0, 5604.551635869202, 5610.887782244414, 5675.347335056521, 5705.286839145107, 5553.777848886161, 5565.220869078251, 5565.276514053309, 5568.1091025435735, 5575.135853942483, 5499.092649712753, 5642.915356269577, 5643.943560564342, 5654.886902261849, 5741.91387129185, 5549.500544950974, 5585.609007369445, 5595.608307418442, 5596.916046259228, 5597.412271711574], "unit": "score", "name": "prototype.html", "value": 4208.252604895609}, {"lowerIsBetter": false, "replicates": [651.280335229571, 685.5167107189432, 717.6053170756086, 728.5956294256686, 740.4261697184683, 12004.699882502942, 12117.091218158652, 12129.0, 12168.209066410689, 13884.791728124086, 13825.930870345634, 13828.861711382882, 13910.652233694163, 13913.860861391384, 13925.930370348135, 652.403051208144, 797.8643630582815, 813.0812182234097, 820.6963423533301, 820.9466384684977, 803.048387660624, 806.0327606871748, 811.059171361221, 816.1226681317578, 816.1756625807947, 843.527624530262, 844.1684940333766, 844.9788755281137, 845.4589062999685, 845.5560830563973, 671.5131529640996, 834.3283656656389, 838.8657814749672, 841.0412130171609, 841.1252297610478, 613.5643692977991, 615.0436071908181, 615.5567991046439, 615.7044618583105, 615.7937091074496, 12337.814932776015, 12431.689207769878, 12493.125481216319, 12494.562690305887, 12515.436805343781, 11586.188966772244, 11716.414179291001, 11798.587049453228, 11979.28124312544, 12229.633111006595, 9578.808423831553, 9832.31173817833, 9848.90151098487, 9895.356801807931, 10457.267991240617, 3301.108700650811, 3359.81521016344, 3386.204242003127, 3405.6934875861043, 3432.7253819694365, 43238.567614323765, 43564.78217608892, 43858.56141438577, 44178.116437671386, 44200.0, 9021.32340074497, 9395.671151509665, 9403.6708715196, 9410.43537387759, 9412.294077944181, 16431.671366572602, 16433.260503277383, 16565.83434165667, 16592.336306547604, 16592.917035414746, 6778.864422711518, 6809.659517024129, 6875.621840798804, 6972.755953541602, 7098.0, 3874.9612503875164, 3891.5330160380936, 3900.6489415952133, 3934.3311637021775, 3971.4709836713073, 2901.50674385355, 2946.0, 2953.42408230393, 2955.748761355309, 2958.304798372381, 526.7418964707342, 544.8719550905613, 559.5914982063117, 567.545963229423, 577.5120023580068, 581.2501872584403, 599.5772980049055, 605.9617542246772, 659.8548319369827, 668.6055227415848, 7539.472236943361, 7673.939484200948, 7877.487963282369, 8201.671933122727, 8341.374396920255, 553.7231384307846, 593.0007936626797, 631.8420394901275, 633.173708310659, 637.4677144584232, 3734.2531493701367, 3847.0, 3861.131245469747, 3867.8066096695616, 3949.842006319715, 46309.073818523444, 46712.53287467082, 46755.0, 46980.53019469762, 47010.0, 43546.346804797955, 43601.78199108984, 44200.77899610481, 44602.77698611486, 44757.10485790266, 38306.99999999944, 38935.415968759924, 39033.21933561313, 39231.21537569233, 40566.0, 7391.8152046199275, 7693.115291741521, 7780.766577002699, 7895.960520197362, 7913.287804097658, 29409.85295073511, 29513.409731805674, 30080.0, 30369.696303036686, 30372.84813575918, 35442.113947150494, 37235.6276437243, 37582.8120859394, 37932.2413551733, 37983.240335193696, 9965.601375944882, 10046.547905344423, 10099.798004040025, 10280.640177593748, 10393.896061039293, 10613.575456981944, 11272.267302625303, 11282.435878205893, 11316.660500185008, 11406.258593191416, 10704.839427408751, 10954.780904381709, 11057.944710276397, 11221.158413118885, 11509.309441433541, 9824.901750982399, 10281.434521101412, 10617.097546708615, 10843.837342440027, 11363.772724545297, 10518.474076296308, 10550.577976880839, 10629.20280978945, 10824.783504330027, 11027.669169924915, 9329.953350233205, 9412.811743765224, 9595.760105997406, 9631.71104866855, 9903.059209375098, 9184.610165432729, 9193.218576420812, 9495.66765163216, 9596.136347728738, 9736.367136136128], "unit": "score", "name": "yui.html", "value": 5881.6213889655955}], "name": "dromaeo_css", "value": 6333.421118069749}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 109.0, 112.0, 113.0, 113.0, 102.0, 111.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 155.0, 184.0, 135.0, 158.0, 156.0, 133.0, 177.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 162.0, 160.0, 163.0, 160.0, 161.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 115.0, 100.0, 74.0, 73.0, 74.0, 119.0, 92.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 135.0, 93.0, 94.0, 94.0, 144.0, 94.0, 93.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 64.0, 75.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.7}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 67.0, 63.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 83.0, 83.0, 85.0, 84.0, 84.0, 85.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 118.0, 128.0, 116.0, 121.0, 129.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 145.0, 160.0, 144.0, 131.0, 133.0, 141.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 69.0, 69.0, 70.0, 66.0, 66.0, 65.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1519.1}]} 09:45:09 INFO - Return code: 0 09:45:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:45:09 ERROR - # TBPL SUCCESS # 09:45:09 INFO - Running post-action listener: _resource_record_post_action 09:45:09 INFO - Running post-run listener: _resource_record_post_run 09:45:10 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519540736; Read time: 12; Write time: 527700 09:45:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232706048; Read time: 0; Write time: 293440 09:45:10 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279941120; Read time: 12; Write time: 231572 09:45:10 INFO - Running post-run listener: _upload_blobber_files 09:45:10 INFO - Blob upload gear active. 09:45:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:10 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 09:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:45:10 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:11 INFO - (blobuploader) - INFO - Done attempting. 09:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:12 INFO - (blobuploader) - INFO - Done attempting. 09:45:12 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:12 INFO - Return code: 0 09:45:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e033daf9c6108c0c480daffc26ff1f38bc4cba3b76e3eb220a803193f66f5fa2ce995cfbd933754a4eeef1103b4961d791dc7683d2f1e9603fa1afd5bcf5a440", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02633f0ba5a67ef63f41668779f62bad68f796774a2b73450dceeac0dff962f8100aafc12f68b966d713a8fd35eabedf4027d34b38335a25c1e9a86815e60d8c"} 09:45:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:12 INFO - Contents: 09:45:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e033daf9c6108c0c480daffc26ff1f38bc4cba3b76e3eb220a803193f66f5fa2ce995cfbd933754a4eeef1103b4961d791dc7683d2f1e9603fa1afd5bcf5a440", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02633f0ba5a67ef63f41668779f62bad68f796774a2b73450dceeac0dff962f8100aafc12f68b966d713a8fd35eabedf4027d34b38335a25c1e9a86815e60d8c"} 09:45:12 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:12 INFO - Copying logs to upload dir... 09:45:12 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.321144 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-28 09:45:12.197289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 09:45:12.201078) ========= 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=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e033daf9c6108c0c480daffc26ff1f38bc4cba3b76e3eb220a803193f66f5fa2ce995cfbd933754a4eeef1103b4961d791dc7683d2f1e9603fa1afd5bcf5a440", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02633f0ba5a67ef63f41668779f62bad68f796774a2b73450dceeac0dff962f8100aafc12f68b966d713a8fd35eabedf4027d34b38335a25c1e9a86815e60d8c"} build_url:https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/EWgyVJKyS6euIPf25qPKdA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e033daf9c6108c0c480daffc26ff1f38bc4cba3b76e3eb220a803193f66f5fa2ce995cfbd933754a4eeef1103b4961d791dc7683d2f1e9603fa1afd5bcf5a440", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02633f0ba5a67ef63f41668779f62bad68f796774a2b73450dceeac0dff962f8100aafc12f68b966d713a8fd35eabedf4027d34b38335a25c1e9a86815e60d8c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 09:45:12.230539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:45:12.230926) ========= 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=7de08804244eb36560b44971000001c3-1459181353.97208-1758109273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:45:12.311941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 09:45:12.312299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 09:45:12.312643) ========= ========= Total master_lag: 0.36 =========