builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1459522158.55 results: success (0) buildid: 20160401055952 builduid: b8951637c3884ac481d99ae003fac424 revision: 21be9fc9356d9ee4f396a5263b0aa1b47266eb8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:18.554523) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:18.554998) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:18.555314) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006507 basedir: '/builds/slave/test' ========= master_lag: 0.23 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:18.793577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:18.793911) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:19.262444) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:19.262856) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.39 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:19.655377) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:19.655694) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:19.656061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:19.656352) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 07:49:21-- 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% 225M=0s 2016-04-01 07:49:21 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.339466 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:20.135805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:20.136130) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013821 ========= master_lag: 0.31 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:20.458030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 07:49:20.458433) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 21be9fc9356d9ee4f396a5263b0aa1b47266eb8a --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 21be9fc9356d9ee4f396a5263b0aa1b47266eb8a --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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 07:49:22,098 truncating revision to first 12 chars 2016-04-01 07:49:22,098 Setting DEBUG logging. 2016-04-01 07:49:22,098 attempt 1/10 2016-04-01 07:49:22,098 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/21be9fc9356d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 07:49:22,797 unpacking tar archive at: fx-team-21be9fc9356d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.003695 ========= master_lag: 0.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 07:49:21.656776) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:21.657141) ========= echo 21be9fc9356d9ee4f396a5263b0aa1b47266eb8a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'21be9fc9356d9ee4f396a5263b0aa1b47266eb8a'] 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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21be9fc9356d9ee4f396a5263b0aa1b47266eb8a program finished with exit code 0 elapsedTime=0.004676 script_repo_revision: '21be9fc9356d9ee4f396a5263b0aa1b47266eb8a' ========= master_lag: 0.49 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:22.151302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:22.151632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 07:49:22.614968) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-01 07:49:22.615407) ========= /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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:49:24 INFO - MultiFileLogger online at 20160401 07:49:24 in /builds/slave/test 07:49:24 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 07:49:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:49:24 INFO - {'append_to_log': False, 07:49:24 INFO - 'base_work_dir': '/builds/slave/test', 07:49:24 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:49:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:49:24 INFO - 'branch': 'Fx-Team-Non-PGO', 07:49:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:49:24 INFO - 'config_files': ('talos/linux_config.py',), 07:49:24 INFO - 'default_actions': ('clobber', 07:49:24 INFO - 'read-buildbot-config', 07:49:24 INFO - 'download-and-extract', 07:49:24 INFO - 'populate-webroot', 07:49:24 INFO - 'create-virtualenv', 07:49:24 INFO - 'install', 07:49:24 INFO - 'run-tests'), 07:49:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:49:24 INFO - 'download_minidump_stackwalk': True, 07:49:24 INFO - 'download_symbols': 'ondemand', 07:49:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:49:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:49:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:49:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:49:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:49:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:49:24 INFO - 'installer_path': 'installer.exe', 07:49:24 INFO - 'log_level': 'info', 07:49:24 INFO - 'log_name': 'talos', 07:49:24 INFO - 'log_to_console': True, 07:49:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:49:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:49:24 INFO - 'opt_config_files': (), 07:49:24 INFO - 'pip_index': False, 07:49:24 INFO - 'sps_profile': False, 07:49:24 INFO - 'sps_profile_interval': 0, 07:49:24 INFO - 'suite': 'dromaeojs', 07:49:24 INFO - 'system_bits': '32', 07:49:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:49:24 INFO - 'title': 'talos-linux64-ix-039', 07:49:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:49:24 INFO - 'use_talos_json': True, 07:49:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:49:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:49:24 INFO - 'work_dir': 'build'} 07:49:24 INFO - ##### 07:49:24 INFO - ##### Running clobber step. 07:49:24 INFO - ##### 07:49:24 INFO - Running pre-action listener: _resource_record_pre_action 07:49:24 INFO - Running main action method: clobber 07:49:24 INFO - rmtree: /builds/slave/test/build 07:49:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:49:25 INFO - Running post-action listener: _resource_record_post_action 07:49:25 INFO - ##### 07:49:25 INFO - ##### Running read-buildbot-config step. 07:49:25 INFO - ##### 07:49:25 INFO - Running pre-action listener: _resource_record_pre_action 07:49:25 INFO - Running main action method: read_buildbot_config 07:49:25 INFO - Using buildbot properties: 07:49:25 INFO - { 07:49:25 INFO - "project": "", 07:49:25 INFO - "product": "firefox", 07:49:25 INFO - "script_repo_revision": "production", 07:49:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:49:25 INFO - "repository": "", 07:49:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:49:25 INFO - "buildid": "20160401055952", 07:49:25 INFO - "pgo_build": "False", 07:49:25 INFO - "basedir": "/builds/slave/test", 07:49:25 INFO - "buildnumber": 1524, 07:49:25 INFO - "slavename": "talos-linux64-ix-039", 07:49:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:49:25 INFO - "platform": "ubuntu64_hw", 07:49:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:49:25 INFO - "branch": "fx-team", 07:49:25 INFO - "repo_path": "integration/fx-team", 07:49:25 INFO - "revision": "21be9fc9356d9ee4f396a5263b0aa1b47266eb8a", 07:49:25 INFO - "stage_platform": "linux64", 07:49:25 INFO - "builduid": "b8951637c3884ac481d99ae003fac424", 07:49:25 INFO - "slavebuilddir": "test" 07:49:25 INFO - } 07:49:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:49:25 INFO - Running post-action listener: _resource_record_post_action 07:49:25 INFO - ##### 07:49:25 INFO - ##### Running download-and-extract step. 07:49:25 INFO - ##### 07:49:25 INFO - Running pre-action listener: _resource_record_pre_action 07:49:25 INFO - Running main action method: download_and_extract 07:49:25 INFO - mkdir: /builds/slave/test/build/tests 07:49:25 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')]} 07:49:25 INFO - https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:49:27 INFO - Downloaded 1361 bytes. 07:49:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:49:27 INFO - Using the following test package requirements: 07:49:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:49:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:49:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:27 INFO - u'jsshell-linux-x86_64.zip'], 07:49:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:49:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:49:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:49:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:49:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:49:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:49:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:49:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:49:27 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')]} 07:49:27 INFO - https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:49:39 INFO - Downloaded 22112056 bytes. 07:49:39 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'] 07:49:39 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 07:49:40 INFO - Return code: 0 07:49:40 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 07:49:40 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')]} 07:49:40 INFO - https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:49:53 INFO - Downloaded 22112056 bytes. 07:49:53 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'] 07:49:53 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 07:49:55 INFO - Return code: 0 07:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:55 INFO - https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:49:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:49:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:49:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:49:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:49:59 INFO - Downloaded 10847534 bytes. 07:49:59 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'] 07:49:59 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 07:50:00 INFO - Return code: 0 07:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:00 INFO - https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:50:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:50:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:50:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BReFw_FdR2CwUhuYkLTYCw/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 07:50:04 INFO - Downloaded 54221193 bytes. 07:50:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:50:04 INFO - mkdir: /builds/slave/test/properties 07:50:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:50:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:50:04 INFO - Contents: 07:50:04 INFO - build_url:https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:50:05 INFO - Running post-action listener: _resource_record_post_action 07:50:05 INFO - Running post-action listener: set_extra_try_arguments 07:50:05 INFO - ##### 07:50:05 INFO - ##### Running populate-webroot step. 07:50:05 INFO - ##### 07:50:05 INFO - Running pre-action listener: _resource_record_pre_action 07:50:05 INFO - Running main action method: populate_webroot 07:50:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:50:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:50:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:50:05 INFO - '--tppagecycles', 07:50:05 INFO - '7'], 07:50:05 INFO - 'tests': ['tsvgm']}}, 07:50:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:50:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:50:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:50:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:50:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'tests': ['damp', 'tps']}, 07:50:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['damp', 'tps']}, 07:50:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:50:05 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['dromaeo_dom']}, 07:50:05 INFO - 'other': {'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other_l64': {'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'other_nol64': {'tests': ['a11yr', 07:50:05 INFO - 'ts_paint', 07:50:05 INFO - 'tpaint', 07:50:05 INFO - 'sessionrestore', 07:50:05 INFO - 'sessionrestore_no_auto_restore', 07:50:05 INFO - 'tabpaint']}, 07:50:05 INFO - 'svgr': {'tests': ['tsvgx', 07:50:05 INFO - 'tsvgr_opacity', 07:50:05 INFO - 'tart', 07:50:05 INFO - 'tscrollx', 07:50:05 INFO - 'cart']}, 07:50:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['tsvgx', 07:50:05 INFO - 'tsvgr_opacity', 07:50:05 INFO - 'tart', 07:50:05 INFO - 'tscrollx', 07:50:05 INFO - 'cart']}, 07:50:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'tests': ['tp5o']}, 07:50:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--e10s'], 07:50:05 INFO - 'tests': ['tp5o']}, 07:50:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--xperf_path', 07:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:05 INFO - 'tests': ['tp5n']}, 07:50:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:05 INFO - 'talos_options': ['--e10s', 07:50:05 INFO - '--xperf_path', 07:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:05 INFO - 'tests': ['tp5n']}}, 07:50:05 INFO - 'talos.zip': {'path': '', 07:50:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:50:05 INFO - Running post-action listener: _resource_record_post_action 07:50:05 INFO - ##### 07:50:05 INFO - ##### Running create-virtualenv step. 07:50:05 INFO - ##### 07:50:05 INFO - Running pre-action listener: _resource_record_pre_action 07:50:05 INFO - Running main action method: create_virtualenv 07:50:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:50:05 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 07:50:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:50:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:50:05 INFO - Using real prefix '/usr' 07:50:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:50:05 INFO - Installing distribute.............................................................................................................................................................................................done. 07:50:07 INFO - Installing pip.................done. 07:50:07 INFO - Return code: 0 07:50:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:50:07 INFO - Using env: {'DISPLAY': ':0', 07:50:07 INFO - 'HOME': '/home/cltbld', 07:50:07 INFO - 'LANG': 'en_US.UTF-8', 07:50:07 INFO - 'LANGUAGE': 'en_US:en', 07:50:07 INFO - 'LOGNAME': 'cltbld', 07:50:07 INFO - 'MAIL': '/var/mail/cltbld', 07:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:07 INFO - 'MOZ_NO_REMOTE': '1', 07:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:07 INFO - 'NO_EM_RESTART': '1', 07:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:07 INFO - 'PWD': '/builds/slave/test', 07:50:07 INFO - 'SHELL': '/bin/bash', 07:50:07 INFO - 'SHLVL': '1', 07:50:07 INFO - 'TERM': 'linux', 07:50:07 INFO - 'TMOUT': '86400', 07:50:07 INFO - 'USER': 'cltbld', 07:50:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:07 INFO - '_': '/tools/buildbot/bin/python'} 07:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:08 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 07:50:08 INFO - Cleaning up... 07:50:08 INFO - Return code: 0 07:50:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:50:08 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')]} 07:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:08 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')]} 07:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:08 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 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:08 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 07:50:08 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 07:50:08 INFO - Using env: {'DISPLAY': ':0', 07:50:08 INFO - 'HOME': '/home/cltbld', 07:50:08 INFO - 'LANG': 'en_US.UTF-8', 07:50:08 INFO - 'LANGUAGE': 'en_US:en', 07:50:08 INFO - 'LOGNAME': 'cltbld', 07:50:08 INFO - 'MAIL': '/var/mail/cltbld', 07:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:08 INFO - 'MOZ_NO_REMOTE': '1', 07:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:08 INFO - 'NO_EM_RESTART': '1', 07:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:08 INFO - 'PWD': '/builds/slave/test', 07:50:08 INFO - 'SHELL': '/bin/bash', 07:50:08 INFO - 'SHLVL': '1', 07:50:08 INFO - 'TERM': 'linux', 07:50:08 INFO - 'TMOUT': '86400', 07:50:08 INFO - 'USER': 'cltbld', 07:50:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:08 INFO - '_': '/tools/buildbot/bin/python'} 07:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:08 INFO - Downloading/unpacking psutil>=0.7.1 07:50: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 07:50: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 07:50: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 07:50: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 07:50: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 07:50: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 07:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:50:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:10 INFO - Installing collected packages: psutil 07:50:10 INFO - Running setup.py install for psutil 07:50:11 INFO - building 'psutil._psutil_linux' extension 07:50:11 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 07:50:11 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 07:50:11 INFO - building 'psutil._psutil_posix' extension 07:50:11 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 07:50:11 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 07:50:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:11 INFO - Successfully installed psutil 07:50:11 INFO - Cleaning up... 07:50:11 INFO - Return code: 0 07:50:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:50:11 INFO - Using env: {'DISPLAY': ':0', 07:50:11 INFO - 'HOME': '/home/cltbld', 07:50:11 INFO - 'LANG': 'en_US.UTF-8', 07:50:11 INFO - 'LANGUAGE': 'en_US:en', 07:50:11 INFO - 'LOGNAME': 'cltbld', 07:50:11 INFO - 'MAIL': '/var/mail/cltbld', 07:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:11 INFO - 'MOZ_NO_REMOTE': '1', 07:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:11 INFO - 'NO_EM_RESTART': '1', 07:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:11 INFO - 'PWD': '/builds/slave/test', 07:50:11 INFO - 'SHELL': '/bin/bash', 07:50:11 INFO - 'SHLVL': '1', 07:50:11 INFO - 'TERM': 'linux', 07:50:11 INFO - 'TMOUT': '86400', 07:50:11 INFO - 'USER': 'cltbld', 07:50:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:11 INFO - '_': '/tools/buildbot/bin/python'} 07:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:50: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 07:50: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 07:50: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 07:50: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 07:50: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 07:50: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 07:50:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:50:14 INFO - Installing collected packages: mozsystemmonitor 07:50:14 INFO - Running setup.py install for mozsystemmonitor 07:50:14 INFO - Successfully installed mozsystemmonitor 07:50:14 INFO - Cleaning up... 07:50:14 INFO - Return code: 0 07:50:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:14 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 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:14 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 07:50:14 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 07:50:14 INFO - Using env: {'DISPLAY': ':0', 07:50:14 INFO - 'HOME': '/home/cltbld', 07:50:14 INFO - 'LANG': 'en_US.UTF-8', 07:50:14 INFO - 'LANGUAGE': 'en_US:en', 07:50:14 INFO - 'LOGNAME': 'cltbld', 07:50:14 INFO - 'MAIL': '/var/mail/cltbld', 07:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:14 INFO - 'MOZ_NO_REMOTE': '1', 07:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:14 INFO - 'NO_EM_RESTART': '1', 07:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:14 INFO - 'PWD': '/builds/slave/test', 07:50:14 INFO - 'SHELL': '/bin/bash', 07:50:14 INFO - 'SHLVL': '1', 07:50:14 INFO - 'TERM': 'linux', 07:50:14 INFO - 'TMOUT': '86400', 07:50:14 INFO - 'USER': 'cltbld', 07:50:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:14 INFO - '_': '/tools/buildbot/bin/python'} 07:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:14 INFO - Downloading/unpacking blobuploader==1.2.4 07:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:16 INFO - Downloading blobuploader-1.2.4.tar.gz 07:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:50:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:50:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:50:17 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 07:50:17 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 07:50:17 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 07:50:17 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 07:50:17 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 07:50:17 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 07:50:17 INFO - Downloading docopt-0.6.1.tar.gz 07:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:50:17 INFO - Installing collected packages: blobuploader, requests, docopt 07:50:17 INFO - Running setup.py install for blobuploader 07:50:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:50:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:50:17 INFO - Running setup.py install for requests 07:50:17 INFO - Running setup.py install for docopt 07:50:17 INFO - Successfully installed blobuploader requests docopt 07:50:17 INFO - Cleaning up... 07:50:18 INFO - Return code: 0 07:50:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:18 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')]} 07:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:18 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')]} 07:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:18 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 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:18 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 07:50:18 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 07:50:18 INFO - Using env: {'DISPLAY': ':0', 07:50:18 INFO - 'HOME': '/home/cltbld', 07:50:18 INFO - 'LANG': 'en_US.UTF-8', 07:50:18 INFO - 'LANGUAGE': 'en_US:en', 07:50:18 INFO - 'LOGNAME': 'cltbld', 07:50:18 INFO - 'MAIL': '/var/mail/cltbld', 07:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:18 INFO - 'MOZ_NO_REMOTE': '1', 07:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:18 INFO - 'NO_EM_RESTART': '1', 07:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:18 INFO - 'PWD': '/builds/slave/test', 07:50:18 INFO - 'SHELL': '/bin/bash', 07:50:18 INFO - 'SHLVL': '1', 07:50:18 INFO - 'TERM': 'linux', 07:50:18 INFO - 'TMOUT': '86400', 07:50:18 INFO - 'USER': 'cltbld', 07:50:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:18 INFO - '_': '/tools/buildbot/bin/python'} 07:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:18 INFO - Running setup.py (path:/tmp/pip-AdOsC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:18 INFO - Running setup.py (path:/tmp/pip-Ya0Laq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:18 INFO - Running setup.py (path:/tmp/pip-6mM4VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:18 INFO - Running setup.py (path:/tmp/pip-TFHf7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:18 INFO - Running setup.py (path:/tmp/pip-qUREma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:18 INFO - Running setup.py (path:/tmp/pip-hER8T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:18 INFO - Running setup.py (path:/tmp/pip-vMlDIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:18 INFO - Running setup.py (path:/tmp/pip-_w5SbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:18 INFO - Running setup.py (path:/tmp/pip-oX2PmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:18 INFO - Running setup.py (path:/tmp/pip-mk1uq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:18 INFO - Running setup.py (path:/tmp/pip-JlRovn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:19 INFO - Running setup.py (path:/tmp/pip-kSG67o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:19 INFO - Running setup.py (path:/tmp/pip-gT1Sut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:19 INFO - Running setup.py (path:/tmp/pip-ysZkFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:19 INFO - Running setup.py (path:/tmp/pip-QC6Ku9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:19 INFO - Running setup.py (path:/tmp/pip-0i_iq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:19 INFO - Running setup.py (path:/tmp/pip-uP4zu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:50:19 INFO - Running setup.py install for manifestparser 07:50:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:50:19 INFO - Running setup.py install for mozcrash 07:50:19 INFO - Running setup.py install for mozdebug 07:50:19 INFO - Running setup.py install for mozdevice 07:50:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:50:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:50:19 INFO - Running setup.py install for mozfile 07:50:19 INFO - Running setup.py install for mozhttpd 07:50:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Running setup.py install for mozinfo 07:50:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Running setup.py install for mozInstall 07:50:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Running setup.py install for mozleak 07:50:20 INFO - Running setup.py install for mozlog 07:50:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Running setup.py install for moznetwork 07:50:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Running setup.py install for mozprocess 07:50:20 INFO - Running setup.py install for mozprofile 07:50:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Running setup.py install for mozrunner 07:50:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:50:20 INFO - Running setup.py install for mozscreenshot 07:50:21 INFO - Running setup.py install for moztest 07:50:21 INFO - Running setup.py install for mozversion 07:50:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:50:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:50:21 INFO - Cleaning up... 07:50:21 INFO - Return code: 0 07:50:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:21 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')]} 07:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:21 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')]} 07:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:21 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 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:21 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 07:50:21 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 07:50:21 INFO - Using env: {'DISPLAY': ':0', 07:50:21 INFO - 'HOME': '/home/cltbld', 07:50:21 INFO - 'LANG': 'en_US.UTF-8', 07:50:21 INFO - 'LANGUAGE': 'en_US:en', 07:50:21 INFO - 'LOGNAME': 'cltbld', 07:50:21 INFO - 'MAIL': '/var/mail/cltbld', 07:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:21 INFO - 'MOZ_NO_REMOTE': '1', 07:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:21 INFO - 'NO_EM_RESTART': '1', 07:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:21 INFO - 'PWD': '/builds/slave/test', 07:50:21 INFO - 'SHELL': '/bin/bash', 07:50:21 INFO - 'SHLVL': '1', 07:50:21 INFO - 'TERM': 'linux', 07:50:21 INFO - 'TMOUT': '86400', 07:50:21 INFO - 'USER': 'cltbld', 07:50:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:21 INFO - '_': '/tools/buildbot/bin/python'} 07:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:21 INFO - Running setup.py (path:/tmp/pip-MAePNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:21 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)) 07:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:21 INFO - Running setup.py (path:/tmp/pip-ODGNJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:21 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)) 07:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:21 INFO - Running setup.py (path:/tmp/pip-pMzCB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:21 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)) 07:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:21 INFO - Running setup.py (path:/tmp/pip-432a1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:21 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)) 07:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:21 INFO - Running setup.py (path:/tmp/pip-REbZqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:21 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)) 07:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:21 INFO - Running setup.py (path:/tmp/pip-cvZxMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:21 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)) 07:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:21 INFO - Running setup.py (path:/tmp/pip-WVg4nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:21 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)) 07:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:21 INFO - Running setup.py (path:/tmp/pip-j8gWxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:22 INFO - Running setup.py (path:/tmp/pip-TuvJKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:22 INFO - Running setup.py (path:/tmp/pip-STAwU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:22 INFO - Running setup.py (path:/tmp/pip-18DThz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:22 INFO - Running setup.py (path:/tmp/pip-okZfHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:22 INFO - Running setup.py (path:/tmp/pip-A0bVva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:22 INFO - Running setup.py (path:/tmp/pip-QBiUms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:22 INFO - Running setup.py (path:/tmp/pip-kbPORS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:22 INFO - Running setup.py (path:/tmp/pip-1oGz2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:22 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)) 07:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:22 INFO - Running setup.py (path:/tmp/pip-5poohD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:22 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)) 07:50:22 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)) 07:50:22 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)) 07:50:22 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)) 07:50:22 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)) 07:50:22 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)) 07:50:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:24 INFO - Downloading blessings-1.6.tar.gz 07:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:50:24 INFO - Installing collected packages: blessings 07:50:24 INFO - Running setup.py install for blessings 07:50:24 INFO - Successfully installed blessings 07:50:24 INFO - Cleaning up... 07:50:24 INFO - Return code: 0 07:50:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:50:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:25 INFO - Reading from file tmpfile_stdout 07:50:25 INFO - Current package versions: 07:50:25 INFO - argparse == 1.2.1 07:50:25 INFO - blessings == 1.6 07:50:25 INFO - blobuploader == 1.2.4 07:50:25 INFO - docopt == 0.6.1 07:50:25 INFO - manifestparser == 1.1 07:50:25 INFO - mozInstall == 1.12 07:50:25 INFO - mozcrash == 0.17 07:50:25 INFO - mozdebug == 0.1 07:50:25 INFO - mozdevice == 0.48 07:50:25 INFO - mozfile == 1.2 07:50:25 INFO - mozhttpd == 0.7 07:50:25 INFO - mozinfo == 0.9 07:50:25 INFO - mozleak == 0.1 07:50:25 INFO - mozlog == 3.1 07:50:25 INFO - moznetwork == 0.27 07:50:25 INFO - mozprocess == 0.22 07:50:25 INFO - mozprofile == 0.28 07:50:25 INFO - mozrunner == 6.11 07:50:25 INFO - mozscreenshot == 0.1 07:50:25 INFO - mozsystemmonitor == 0.0 07:50:25 INFO - moztest == 0.7 07:50:25 INFO - mozversion == 1.4 07:50:25 INFO - psutil == 3.1.1 07:50:25 INFO - requests == 1.2.3 07:50:25 INFO - wsgiref == 0.1.2 07:50:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:25 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')]} 07:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:25 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')]} 07:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:25 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 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:25 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 07:50:25 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 07:50:25 INFO - Using env: {'DISPLAY': ':0', 07:50:25 INFO - 'HOME': '/home/cltbld', 07:50:25 INFO - 'LANG': 'en_US.UTF-8', 07:50:25 INFO - 'LANGUAGE': 'en_US:en', 07:50:25 INFO - 'LOGNAME': 'cltbld', 07:50:25 INFO - 'MAIL': '/var/mail/cltbld', 07:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:25 INFO - 'MOZ_NO_REMOTE': '1', 07:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:25 INFO - 'NO_EM_RESTART': '1', 07:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:25 INFO - 'PWD': '/builds/slave/test', 07:50:25 INFO - 'SHELL': '/bin/bash', 07:50:25 INFO - 'SHLVL': '1', 07:50:25 INFO - 'TERM': 'linux', 07:50:25 INFO - 'TMOUT': '86400', 07:50:25 INFO - 'USER': 'cltbld', 07:50:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:25 INFO - '_': '/tools/buildbot/bin/python'} 07:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 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)) 07:50:25 INFO - Cleaning up... 07:50:25 INFO - Return code: 0 07:50:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:50:25 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')]} 07:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:25 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')]} 07:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:25 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 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:25 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 07:50:25 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 07:50:25 INFO - Using env: {'DISPLAY': ':0', 07:50:25 INFO - 'HOME': '/home/cltbld', 07:50:25 INFO - 'LANG': 'en_US.UTF-8', 07:50:25 INFO - 'LANGUAGE': 'en_US:en', 07:50:25 INFO - 'LOGNAME': 'cltbld', 07:50:25 INFO - 'MAIL': '/var/mail/cltbld', 07:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:25 INFO - 'MOZ_NO_REMOTE': '1', 07:50:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:25 INFO - 'NO_EM_RESTART': '1', 07:50:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:25 INFO - 'PWD': '/builds/slave/test', 07:50:25 INFO - 'SHELL': '/bin/bash', 07:50:25 INFO - 'SHLVL': '1', 07:50:25 INFO - 'TERM': 'linux', 07:50:25 INFO - 'TMOUT': '86400', 07:50:25 INFO - 'USER': 'cltbld', 07:50:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:25 INFO - '_': '/tools/buildbot/bin/python'} 07:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:25 INFO - Downloading/unpacking jsonschema 07:50:25 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 07:50:25 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 07:50:25 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 07:50:25 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 07:50:25 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 07:50:25 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 07:50:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:50:27 INFO - Downloading/unpacking functools32 (from jsonschema) 07:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:50:27 INFO - warning: no files found matching '*.txt' 07:50:27 INFO - no previously-included directories found matching 'build' 07:50:27 INFO - no previously-included directories found matching 'dist' 07:50:27 INFO - no previously-included directories found matching '.git*' 07:50:27 INFO - Installing collected packages: jsonschema, functools32 07:50:27 INFO - Running setup.py install for functools32 07:50:27 INFO - warning: no files found matching '*.txt' 07:50:27 INFO - no previously-included directories found matching 'build' 07:50:27 INFO - no previously-included directories found matching 'dist' 07:50:27 INFO - no previously-included directories found matching '.git*' 07:50:27 INFO - Successfully installed jsonschema functools32 07:50:27 INFO - Cleaning up... 07:50:27 INFO - Return code: 0 07:50:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:50:27 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')]} 07:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:27 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')]} 07:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:27 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 0x7f2ee3689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', '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 07:50:27 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 07:50:27 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 07:50:27 INFO - Using env: {'DISPLAY': ':0', 07:50:27 INFO - 'HOME': '/home/cltbld', 07:50:27 INFO - 'LANG': 'en_US.UTF-8', 07:50:27 INFO - 'LANGUAGE': 'en_US:en', 07:50:27 INFO - 'LOGNAME': 'cltbld', 07:50:27 INFO - 'MAIL': '/var/mail/cltbld', 07:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:27 INFO - 'MOZ_NO_REMOTE': '1', 07:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:27 INFO - 'NO_EM_RESTART': '1', 07:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:27 INFO - 'PWD': '/builds/slave/test', 07:50:27 INFO - 'SHELL': '/bin/bash', 07:50:27 INFO - 'SHLVL': '1', 07:50:27 INFO - 'TERM': 'linux', 07:50:27 INFO - 'TMOUT': '86400', 07:50:27 INFO - 'USER': 'cltbld', 07:50:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:27 INFO - '_': '/tools/buildbot/bin/python'} 07:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:28 INFO - Downloading/unpacking flake8 07:50:28 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 07:50:28 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 07:50:28 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 07:50:28 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 07:50:28 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 07:50:28 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 07:50:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:50:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:50:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 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 07:50:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:50:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:50:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:50:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:50:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:50:30 INFO - no previously-included directories found matching 'docs/_build' 07:50:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:50:30 INFO - Running setup.py install for pep8 07:50:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:50:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:50:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:50:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:50:30 INFO - no previously-included directories found matching 'docs/_build' 07:50:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:50:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:50:30 INFO - Cleaning up... 07:50:31 INFO - Return code: 0 07:50:31 INFO - Running post-action listener: _resource_record_post_action 07:50:31 INFO - Running post-action listener: _start_resource_monitoring 07:50:31 INFO - Starting resource monitoring. 07:50:31 INFO - ##### 07:50:31 INFO - ##### Running install step. 07:50:31 INFO - ##### 07:50:31 INFO - Running pre-action listener: _resource_record_pre_action 07:50:31 INFO - Running main action method: install 07:50:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:31 INFO - Reading from file tmpfile_stdout 07:50:31 INFO - Detecting whether we're running mozinstall >=1.0... 07:50:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:50:31 INFO - Reading from file tmpfile_stdout 07:50:31 INFO - Output received: 07:50:31 INFO - Usage: mozinstall [options] installer 07:50:31 INFO - Options: 07:50:31 INFO - -h, --help show this help message and exit 07:50:31 INFO - -d DEST, --destination=DEST 07:50:31 INFO - Directory to install application into. [default: 07:50:31 INFO - "/builds/slave/test"] 07:50:31 INFO - --app=APP Application being installed. [default: firefox] 07:50:31 INFO - mkdir: /builds/slave/test/build/application 07:50:31 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'] 07:50:31 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 07:50:46 INFO - Reading from file tmpfile_stdout 07:50:46 INFO - Output received: 07:50:46 INFO - /builds/slave/test/build/application/firefox/firefox 07:50:46 INFO - Running post-action listener: _resource_record_post_action 07:50:46 INFO - ##### 07:50:46 INFO - ##### Running run-tests step. 07:50:46 INFO - ##### 07:50:46 INFO - Running pre-action listener: _resource_record_pre_action 07:50:46 INFO - Running main action method: run_tests 07:50:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:50:46 INFO - Python 2.7.3 07:50:46 INFO - Return code: 0 07:50:46 INFO - grabbing minidump binary from tooltool 07:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:46 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 0x2205410>, '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 0x2206310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22067a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:50:46 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 07:50:46 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 07:50:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:50:47 INFO - Return code: 0 07:50:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:50:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:50:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:50:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:50:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:50:48 INFO - Return code: 0 07:50:48 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/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:50:48 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/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 07:50:48 INFO - Using env: {'DISPLAY': ':0', 07:50:48 INFO - 'HOME': '/home/cltbld', 07:50:48 INFO - 'LANG': 'en_US.UTF-8', 07:50:48 INFO - 'LANGUAGE': 'en_US:en', 07:50:48 INFO - 'LOGNAME': 'cltbld', 07:50:48 INFO - 'MAIL': '/var/mail/cltbld', 07:50:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:50:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:48 INFO - 'MOZ_NO_REMOTE': '1', 07:50:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:48 INFO - 'NO_EM_RESTART': '1', 07:50:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:48 INFO - 'PWD': '/builds/slave/test', 07:50:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:50:48 INFO - 'SHELL': '/bin/bash', 07:50:48 INFO - 'SHLVL': '1', 07:50:48 INFO - 'TERM': 'linux', 07:50:48 INFO - 'TMOUT': '86400', 07:50:48 INFO - 'USER': 'cltbld', 07:50:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695', 07:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:48 INFO - '_': '/tools/buildbot/bin/python'} 07:50:48 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/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 07:50:48 INFO - mozversion application_buildid: 20160401055952 07:50:48 INFO - mozversion application_changeset: 21be9fc9356d9ee4f396a5263b0aa1b47266eb8a 07:50:48 INFO - mozversion application_display_name: Nightly 07:50:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:50:48 INFO - mozversion application_name: Firefox 07:50:48 INFO - mozversion application_remotingname: firefox 07:50:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:50:48 INFO - mozversion application_vendor: Mozilla 07:50:48 INFO - mozversion application_version: 48.0a1 07:50:48 INFO - mozversion platform_buildid: 20160401055952 07:50:48 INFO - mozversion platform_changeset: 21be9fc9356d9ee4f396a5263b0aa1b47266eb8a 07:50:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:50:48 INFO - mozversion platform_version: 48.0a1 07:50:48 INFO - using testdate: 1459522248 07:50:48 INFO - actual date: 1459522248 07:50:48 INFO - starting webserver on 'localhost:52955' 07:50:48 INFO - SUITE-START | Running 2 tests 07:50:48 INFO - TEST-START | dromaeo_css 07:50:48 INFO - operating with platform_type : linux_ 07:50:48 INFO - Initialising browser for dromaeo_css test... 07:50:48 INFO - TEST-INFO | started process 6608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7S7zoj/profile http://localhost:52955/getInfo.html) 07:50:52 INFO - PROCESS | 6608 | __metrics Screen width/height:1600/1200 07:50:52 INFO - PROCESS | 6608 | colorDepth:24 07:50:52 INFO - PROCESS | 6608 | Browser inner width/height: 1024/697 07:50:52 INFO - PROCESS | 6608 | __metrics 07:50:53 ERROR - PROCESS | 6608 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:50:54 INFO - TEST-INFO | 6608: exit 0 07:50:54 INFO - Browser initialized. 07:50:54 INFO - Running cycle 1/1 for dromaeo_css test... 07:50:54 INFO - TEST-INFO | started process 6690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7S7zoj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:06 INFO - PROCESS | 6690 | RSS: Main: 154898432 07:51:06 INFO - PROCESS | 6690 | 07:51:57 INFO - PROCESS | 6690 | 1459522317955 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] 07:54:09 INFO - PROCESS | 6690 | Cycle 1(1): loaded http://localhost:52955/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52955/tests/dromaeo/cssquery-ext.html) 07:54:10 INFO - PROCESS | 6690 | RSS: Main: 223113216 07:54:10 INFO - PROCESS | 6690 | 07:57:13 INFO - PROCESS | 6690 | Cycle 1(1): loaded http://localhost:52955/tests/dromaeo/cssquery-ext.html (next: http://localhost:52955/tests/dromaeo/cssquery-jquery.html) 07:57:13 INFO - PROCESS | 6690 | RSS: Main: 236736512 07:57:13 INFO - PROCESS | 6690 | 08:00:15 INFO - PROCESS | 6690 | Cycle 1(1): loaded http://localhost:52955/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52955/tests/dromaeo/cssquery-mootools.html) 08:00:16 INFO - PROCESS | 6690 | RSS: Main: 246652928 08:00:16 INFO - PROCESS | 6690 | 08:03:18 INFO - PROCESS | 6690 | Cycle 1(1): loaded http://localhost:52955/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52955/tests/dromaeo/cssquery-prototype.html) 08:03:18 INFO - PROCESS | 6690 | RSS: Main: 223494144 08:03:18 INFO - PROCESS | 6690 | 08:06:21 INFO - PROCESS | 6690 | Cycle 1(1): loaded http://localhost:52955/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52955/tests/dromaeo/cssquery-yui.html) 08:06:22 INFO - PROCESS | 6690 | RSS: Main: 207249408 08:06:22 INFO - PROCESS | 6690 | 08:09:24 INFO - PROCESS | 6690 | Cycle 1(1): loaded http://localhost:52955/tests/dromaeo/cssquery-yui.html (next: http://localhost:52955/tests/dromaeo/cssquery-dojo.html) 08:09:25 INFO - PROCESS | 6690 | RSS: Main: 270897152 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - PROCESS | 6690 | __start_tp_report 08:09:25 INFO - PROCESS | 6690 | _x_x_mozilla_page_load 08:09:25 INFO - PROCESS | 6690 | _x_x_mozilla_page_load_details 08:09:25 INFO - PROCESS | 6690 | |i|pagename|runs| 08:09:25 INFO - PROCESS | 6690 | |0;dojo.html;2619.096411737951;2702.486527559765;2707.9187624371275;2720.673519177699;2749.340158361993;4498.572635599621;4602.884927876805;4615.515370886059;4627.398438203033;4631.8610441686715;4614.907701845961;4627.167109920213;4649.69776964497;4685.461171965217;4696.412948381452;4250.319948808191;4278.465191851019;4304.784760761965;4337.848175313865;4416.050549131936;4387.758673272952;4425.402570652969;4437.733735975836;4444.533324000982;4474.306482495218;4210.221109094828;4247.299195632717;4297.8495752648505;4310.80601372939;4327.199468098381;4252.425922500453;4256.318988961782;4257.787110644455;4298.204832106039;4317.201317756225;4256.212600668886;4264.893377665552;4271.615554600101;4288.485381754178;4295.570442955711;4392.494863090722;4410.338449232609;4502.459704835441;4511.436070491189;4532.660050496226;4954.232094025432;4996.225585034325;5001.824936127255;5009.599232061463;5009.924851127236;5025.572826309768;5033.471485494044;5035.823746168903;5036.949630503685;5061.848144555669;4567.132244873464;4590.265557510782;4629.768511574408;4668.85993420198;4679.227927391942;5092;5097.057044446789;5108.2848401223855;5114.590832733373;5117.820876269313;4699.060187962421;4913.975430122827;4915.48387419323;4915.65590408668;4955.603551715854;4945.431275403303;4973.593088734228;4979.626528010342;5021.472745361758;5027.572656324181;4872;4872.220444728827;4872.707637541759;4884.3650325457465;4914.975425122851;4816.470188279286;4862.621267637767;4867.075255701406;4906.288588154697;4913.164761990471;4187.078842654611;4204.033072393367;4212.094399704079;4232.830686772556;4247.893802654897;3692.316921369555;3702.2965636528975;3708.42519409492;3720.9441858372147;3742.36379815432;4224.408582798411;4272.46594175728;4282.850100246539;4285.6785741068925;4310.892227694333;4963.5780958618925;4970.65205435616;4982.177940639754;4993.950060499421;5020.472850350734;4254.404383386328;4256.702030857872;4258.659307255412;4264.04059086703;4298.806553705091;4402.757848318373;4466.3523789050405;4491.820327186876;4491.977540112344;4559.658025648089;4761.833335833229;4765.11845308619;4766.785494652819;4787.593054590398;4789.25766506199;5022.070916880389;5024.271480635361;5024.522670346311;5026.220935754964;5068.062408454448;4631.490536040966;4681.742504162304;4755.144074066701;4755.334253204624;4772.928406073842;4879.194932836184;4887.0714564232685;4893.7797799099835;4896.436909755281;4940.036692844861;4953.950460495349;4956.479569645136;4958.628102892226;4962.156433406401;5009.674371166008;4574.61115805147;4789.185838407409;4851.34506841586;4886.65793394459;4888.58447031992;4795.904081918272;4800.879978000578;4806.951930480651;4818.277258411266;4871.464138944642;4566.041131362451;4751.334813126235;4752.9287060694805;4754.786034628519;4803.879903002453;4748.192807222711;4801.639877009168;4832.8791780205775;4836.202026665561;4922.704637721748;4717.481077081587;4721.952780472151;4722.197226471577;4744.620430365493;4756.7145971241835 08:09:25 INFO - PROCESS | 6690 | |1;ext.html;532.0874699889688;535.8553190638526;536.7235873525135;548.1284757235994;559.0858945623904;26977.46045079097;27344.316392090182;27422.314442138955;34551.65448345516;35485.822570887176;41044.38433423501;42000.369994450106;42102.36846447298;42123.78938105313;42191.78904105483;7851.411144164182;8048.637811298477;8053;8054.556999365032;8055.476394034398;7752;7876.80307992299;7880.133185349607;7881.330086942588;7882;7853.528788272693;7880;7912.446128770988;7925;7929.801754956144;7790.376769858398;7790.688372465094;7820.726274580419;7883.526988380716;7884.881726774103;7813.843723125562;7925.96037019817;7942.324902383304;7942.602869856484;7945.841083178304;38711.41932871009;39484.21031579381;39508.802455987534;39512.40731389031;39538.40692389588;3089.088718827951;3094.8297843618593;3105.8757649693985;3196.184972831936;3346.1467325832;28625.57061644077;28789.28026799347;28908.277293067633;28959;29466.263343416373;3503.807290599016;3505.8247087645773;3585.0499617601095;3603.4774957631;3604.7837129772297;231747;231983.8400808002;232186;232656;233662;55860;56209.43790562042;56258.15612765812;56304.155437668465;56393;60182.398176018556;62356.376436235965;63747;63780.36219637837;63799;12704.745905081847;12949.352532373343;13138.737225255441;13147.14543554666;13152.145110567782;9879.308448408543;9935.453550054672;9939.50302484873;9972.900270997343;9975.301728878909;19972.10125544354;20309.89845050765;20347.796522034885;20355.796442035688;20400.693989590167;7098.183708873443;7305.780826575211;7441.23304439064;7450.217727138681;7528.682480565879;869.9782505437288;888.4447220487195;958.9472579008082;978.9118979291898;980.67147505585;25665.87167064153;26095.73904260971;26452.8677356612;26561.33596660099;26648.20055398341;938.202527851321;953.0897992417225;958.152035448619;1027.2347101409498;1103.87857335693;13349.46602135923;13646.795298070538;13944.16335019902;13995.86004139966;14065.507707230197;279801;284623;284641;284791;285137;48107.27839082417;48616.75691621519;48720.51279487231;48745.756271218415;48811.267830982564;996.5764550066193;1122.825961975895;1135.8580177477816;1191.4400231890997;1226.0926914083514;24456.388590285384;24500;24557.631635525126;24614.753852461246;24650.630240546765;33551.83224083864;33991.81028663985;34447.82776086104;34690.132746681535;34736.82631586927;175812;176837;176900;177263;177760;31499.370012600077;31997;40341;40657.39013914735;40848.59151408567;36743.81628091949;36891;37003.814980926;37627.24745505129;37849;31642.36715265728;31726.52410213895;33065.834670826494;34138.14654633654;34249.65750342465;33381.66618333785;33585.49621755627;33770.493442597886;33824;34242.31515369629;31155.221119471287;32259.838700806347;35146.12134696653;36562.08594785152;36640.26719465649;27377;28451.28871778222;28644.283892902844;30347.544786827773;30649.080527584207;23860.16489422862;24724.25827225186;24821.255362339158;26688.19935401941;27814.86092569524 08:09:25 INFO - PROCESS | 6690 | |2;jquery.html;335.1587515336505;340.6559375031218;345.72169403630085;357.33000623830316;363.4257872561353;14797.92601036996;15315.923420382896;15856.445024424147;15894.682106357866;15936.521904342859;10448.477576121202;10660.78678426431;10705.14358851292;15733.685326293496;15846.445374411898;4302.096559722462;4426.889327766799;4431.069475410168;4432.490263619693;4444.133393988173;4396.912061758763;4417.182821178077;4456.420665313504;4934.777934992916;4946.2580612908;4891.559759621633;4897.975510122445;4909.7545122743895;4927.433345165298;4931.654784165092;4539.818407263706;4956.479569645189;4960.280759289883;4965.975170124144;4967.577755890754;4470;4483.551644835523;4504.054148628792;4505.662075344362;4508.143452743968;12218.20581662189;12428.192167509083;12435.378231088409;15733.449329273535;19860.503487412785;1856.053412759489;1859.228420205613;1872.662920674278;1905.237904838062;2248.5053288276554;9096.818063638757;9220.662766099704;10865.891341086566;11390.430478476126;12726.10917235794;1740.9216585253694;1764.7352897065414;1800.7208882623215;1831.1393644986836;1844.8708590398544;41966.37050444246;43539.346909796375;55317.170242445995;58056.419435805525;58163.41836581622;8965.193132617966;9296;9423.199028082552;9594.568244429018;9643.324967252225;11428.599998999995;11790.23363481371;12110.81833772494;13051.673708157372;13076;5648.378678345379;5665.66006039639;5752.769889204469;5768.307803063659;5787.71061446926;5009.799608015638;5054.949450505522;5164.122099243138;5164.225366195101;5166.3800343958965;4067.572904845008;4101.487314085739;4124.278251306069;4185.644220241253;4194.937075943863;1703.0122528933189;1784.1792775323497;1796.4790210838971;1820.126339357116;1846.2799508191815;869.4392117084572;916.2349438219028;937.3251259093441;946.2382781860531;954.9952250238844;15327.310271037608;16038.198090095682;16083.758743618855;16122.435714749927;16215.432459863849;940.8212439636447;941.463365881441;947.8151760406655;955.016333176829;956.7942892278194;8972.327075469366;9083;9180.586873590704;9353.859692104625;9402.247820174507;366876;395908;403091;403319;410366;67998;71604.64197678979;73822;74553;75434;953.113604347963;972.3533849989677;973.8344481438314;998.8451789972565;998.9001099890098;14725.484608038667;14846.628834279229;14894.925525372304;15024.549263522113;15227.695446090795;30858.919937802068;32881.506777398834;33219.33561328808;33473.665263348026;33684.83157584196;46739;47629.28556071592;47791.76104119457;47956.5204347952;49312.260316096006;7383.15093764224;7427.480076394817;7463.626818659154;7562;7738.458307918617;8904.73285801427;11152.665420037412;11503.712407189552;11520.078393728314;11996.100292478273;9995.70012899614;10238.385696858213;10302.124319432933;10351.120154786928;10394.324368915995;6606.735730570724;9954.800903982024;10023.849642255225;10424.009719076676;10512.57949682004;9986.151177149733;10403;10444.112250458797;10548.050675439248;10739.624113156002;7149.857002860018;7353.632318383952;7407.111146662435;7550.169481357156;7653.387728981779;10188.847167292348;10440.37357758537;10449.791004180026;10498.527566259383;10649.467526623794 08:09:25 INFO - PROCESS | 6690 | |3;mootools.html;1300.1224173682763;1403.4736973634886;1422.2959634980682;1547.1645311531774;1772.0873750018734;6962.373386395224;7141.25016873228;7146.499745017851;7162.212156662763;7165.390941769942;7016.052832867561;7182;7187.245339239383;7188.4249260059205;7195.712171513133;1877.6901811201135;1920.6350793349288;1921.0970843703437;2183.3559100065518;2209.845310828243;2178.4880553070016;2250.4036430345973;2254.88725563722;2255.3234029790997;2256.187772401934;2178.5207254404004;2208.249195273607;2214.634585293433;2215.8670479771267;2219.3563866478703;2160.5570857974076;2168.3820111268215;2170.6852506386645;2171.902264398098;2177.695122682818;2053.1787285086084;2083.468715477559;2083.95832083359;2085.666293393065;2086.1655337864822;7304.123505179413;7304.342609165201;7343.118825740945;7356.889646655304;7379;4200.6219440250525;4307.203167414038;4317.438732964726;4318.805653745589;4324.913501729948;2800.565912283599;2829.363393236526;2860.184847318525;2873.726995935383;2901.04265592354;904.9411788233809;946.9526523673858;952.6849755095116;959.6257459590765;960.2810968366615;9949.204063674888;9950.402975821475;9957.502124893726;9959.452230127341;9978.850317245247;4058.411530328086;4070.9389359159636;4130.153318569686;4192.685548583869;4206.663466922639;8541.743747687578;8599;8618.224359807647;8620;8638.049814520398;4350.978245108754;4370.934435983463;4382.496012958551;4387.254166791653;4388.078503514298;3383.035834787123;3794.905127371838;3930.744501607386;3992.4210989406374;3994.8801535953967;3382.661733826598;3447.6035255945385;3459.2562599041325;3476.0440878758036;3489.8778542750883;1144.227646338718;1187.8158885372782;1190.3393616542728;1195.6891208285908;1205.4756181061266;1111.7165122893773;1128.3793913347627;1135.9659210223706;1146.1518476327458;1182.3319824299244;6651.068850360954;6756.662166891636;6784.898226526606;6791.252962174157;6826.692798824065;455.2329325087239;467.0635376070956;467.2733898787418;469.4999825186166;472.8486884197093;5086.872828179326;5093.1341671915125;5108.361454818148;5135.6405051646025;5143.588512919032;8497.915020849712;8575.871361929576;8775.648974040967;8903.465792052497;8919.777005574782;8744.8688269676;8790.384673072824;8812.250958668585;8815;8821.60302786376;6640.269570347355;6845.5550389224545;6923.030775691407;6972.546784459096;6974.546654467444;6800.625965571941;6830.043793868962;6878.965605171942;6894.965525172342;6895.689693963684;7883.448158628841;7887.802804929923;8068.838623227385;8154.551499667576;8204.425690201628;8153.55155466455;8365.95817020911;8373.120822313569;8415.70545030921;8500.957495212731;5443.401225865073;5886.793962211302;6087.421694938974;6441.645709485836;6550.082988381535;6571.605703657796;6632.270450250565;6662.766803161866;6674.83312917181;6682.899756503559;5771.8557036074435;5833;5915.40845915405;5921.171036055042;5946.316173640087;5747.339056008445;5779.364269930388;5828.417158284307;5869.589128760946;5948.762049518144;6410.647414392253;6421.8073457796345;6568.540202185801;6610.900836487361;6611.338866113542;5990.430909063632;6001.669908155093;6009.879802404015;6023.548233882389;6038.275406951194;6143.139960405636;6155.076738489262;6189.96905015472;6195.318514963441;6243.43809057187 08:09:25 INFO - PROCESS | 6690 | |4;prototype.html;315.18681800953544;320.79469139750563;327.4400774675305;329.1015527609627;329.89773170317187;5338.866528336794;5377.300950876385;5436.238926550286;5436.238926550286;5438.619296649226;5331.520163185322;5337.359516857973;5350.30446042015;5353.678779273237;5363.712708949854;3996.6802655787615;4033.495813023372;4115.32097203961;4120.546739858613;4145.523264824554;4097.89755256118;4122.093139509303;4122.546519882811;4123.9381409278885;4159.251334759742;4014.5383280922774;4058.370952502352;4101.405296232045;4101.651359634435;4102.220578090169;4060.309747342944;4138.8344466221315;4144.150449157915;4152.294110001307;4152.875413737593;3665.6151104134215;3676.1728611062563;3680.35593771089;3682.208325210093;3687.059799751073;4986.725730084844;4990.176620857555;4994.250862370637;4997.100521906055;5031.899362012776;4830.758462076918;4837.854864354075;4840.5159484051665;4841.2012018016985;4841.491643377465;5589.524890384281;5631.8028868989795;5634.661920284796;5652.660840349592;5657.3494048184575;3804.353259945816;4081.3877918312196;4081.387791831249;4082.0815316553835;4086.080631857838;5862.237909071793;5914.940850591525;5916.97041514794;5922.437368450033;5922.763089476416;3953.5058117735284;3954.6045395460224;3956.940645890314;3958.8614398495915;3965.4250133731025;4002.4996875390575;4012.658923991435;4013.538443079083;4013.9598604013586;4016.859409920639;4615;4621.399218101626;4649.18639238132;4652.767361631905;4652.8135325491785;5586.804461843816;5590.273264475592;5591.30108736408;5592.496675299242;5601.243832082617;1389.6456403617012;1414.943402263898;1441.6467965348347;1441.9134851908918;1445.9204743739194;897.2821742605889;938.0666237094135;939.3940908114365;959.3332633819429;966.6665000574791;4859.6916464679;4884.242942343943;4911.287863259879;4917.434495033045;4924.335214745964;5757.050086735725;5785.334686511105;5786.3056433228285;5787.768489260467;5833.095870140135;4888.7311197884455;4899.779509922062;4910.386201724785;4912.042151780369;4915.992221594564;3079.5534647475993;3109.9222519436744;3110.23799169205;3112.128603990886;3115.2367669920563;5479.75341109651;5485.945140548623;5486.067368547357;5486.588505861996;5491.780328786804;5890.322612899486;6072.757089716361;6073.939260607337;6080.118382834465;6084.513238940963;5567.832965011056;5590.804321848797;5601.243832082617;5605.775768969195;5607.915881261784;5854.121881717606;5854.297484301911;5900.940990590039;5903.616264942765;5914.3198532167635;5774.653520788766;5789.1895134680335;5791.276090488689;5791.333996590278;5796.594238403271;5410.161424979135;5585.609007369445;5593.8321850344555;5598.664080155204;5607.635503692411;3928.2143571285287;3952.4268980997017;3964.226975739703;3966.464527288779;3967.166894952092;5876.382979787061;5877.853053673693;5881.676507791942;5884.382139875252;5889.5582831286965;5685.744141513725;5689.1750696148;5693.3168019837885;5703.543716502587;5707.200991861226;5667.659940403589;5683.9715801420725;5691;5692.31692196939;5709.22925405065;5397.514223719884;5595.048841697003;5596.580256480862;5603.831885043455;5620.072688006433;5715.39988301239;5732.512736417451;5742.19609254713;5744.396838331915;5752.741126649395;5589.608727389043;5605.2713147292225;5608.971955140199;5610.6072574921;5619.80330688424 08:09:25 INFO - PROCESS | 6690 | |5;yui.html;641.7433026789283;752.7892190186748;761.1551178192205;762.6529928882352;787.8188016756146;11602.477888495017;11666.533338666464;11707.590234341811;11719.648410547676;11738.178327517067;11580.826287605672;11610.419479026035;11662.125340599447;11686.305485704588;11691.123165762581;629.7921685843684;780.0989856715503;782.1201148707704;807.9919200808005;812.9715459958873;793.436659971421;805.1867613710136;805.5931754463987;812.0823469479479;812.6058861452191;839.7396806989822;853.9786505337386;856.1010938514535;857.5840717252128;857.7298151082389;662.8110988368315;815.9347252219808;828.0105274197336;837.5058715357907;838.7777239031661;614.3610644929269;617.4967401567708;622.6108682073703;623.4793947054216;624.4005754475709;11609.18735688502;11649.068074554016;11654.417279136009;11670.708232294175;11673.124515661275;11914.404279785977;12418.627441176779;12806.103572749911;12906.612801615967;13102;9046.81906361869;9370.39092458988;9583.185429238523;9613.423194608346;9728.367656102402;3329.217633856042;3356.5133055706788;3375.729941604666;3393.830308484566;3463.619001909788;42039.36940945888;42186.17419515847;42229.366559501635;42591.57408425907;42612.3608145878;9429.528523573794;9456.338056336128;9639.18066964302;9656.27577931658;9862.45756483386;17410.39063632792;17417.780755347256;17431.477055688098;17653.558661033578;17701.55746106332;6514.609123452608;6728.831779205559;6736.562123461959;6747.865042699119;6850.760223392157;3491.0399640099176;3523.242502861897;3571.428571428559;3626.256617393428;3632.182758879231;2751.6285301484045;2784.6240757497885;2787.958180627292;2788.930276743057;2799.3701417180973;485.65761138397346;502.11376919736693;505.44653604303227;515.3866898390903;517.6014468859033;460.0339287496298;507.0796504344603;544.779364357428;597.1401182297478;617.6880675258966;7814.492058016211;7843.529388236724;7934.484258523177;8021.558814265271;8254.628541715638;618.9199846268291;624.316373570939;624.447364082781;629.7953165221321;645.7384759172543;3668.853245870189;3698.204885949534;3738.476613274144;3841.7310788245113;3860.6294765358457;48730.53934006986;49497.75251123722;49993.75003125034;50358.748206259464;50443.747781260856;45347.77326113348;45878.54121458743;46299.768501157276;46374.76812615915;46632.06735865264;40530.594694053274;40755.7962210187;40972.1805563893;41018.38472422916;41446.1710765783;7258.818529536804;7414.406847452083;7462.589557574385;7571.583562904093;7703.499272547267;30485.23786905345;31309.53035704421;32284.19289517781;32562;33298.33403331968;38234.61765382422;40292;40581.18837623172;40872.386914196904;40917;9127.406718563272;9168.816623667355;9314.34799564024;9366.438013719198;10877.12982961377;11258.662240132482;11449.885501145216;11581.536738530365;11859.22915010556;12017.399130043637;10945.124390048617;10962.451877406258;10982.890171098186;11277.210595258253;11282.66152015408;10366.5335059924;10665.040146386862;10813;11029.172812038969;11640.185187037165;10596.364218146937;10828.783424331627;10971.835422468828;11067.059299959594;11474.827877582009;7486.401087913063;9540.379875308083;9543.093406126407;9919.256055795988;9968.60125594997;9601;9769.804603908024;9770.80458390814;9833.4099954003;9950.502474876082 08:09:25 INFO - PROCESS | 6690 | __end_tp_report 08:09:25 INFO - PROCESS | 6690 | __start_cc_report 08:09:25 INFO - PROCESS | 6690 | _x_x_mozilla_cycle_collect,1026 08:09:25 INFO - PROCESS | 6690 | __end_cc_report 08:09:25 INFO - PROCESS | 6690 | __startTimestamp1459523365152__endTimestamp 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - PROCESS | 6690 | ------- Summary: start ------- 08:09:25 INFO - PROCESS | 6690 | Number of tests: 6 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - PROCESS | 6690 | [#0] dojo.html Cycles:165 Average:4594.90 Median:4722.20 stddev:463.45 (9.8%) stddev-sans-first:438.19 08:09:25 INFO - PROCESS | 6690 | Values: 2619.1 2702.5 2707.9 2720.7 2749.3 4498.6 4602.9 4615.5 4627.4 4631.9 4614.9 4627.2 4649.7 4685.5 4696.4 4250.3 4278.5 4304.8 4337.8 4416.1 4387.8 4425.4 4437.7 4444.5 4474.3 4210.2 4247.3 4297.8 4310.8 4327.2 4252.4 4256.3 4257.8 4298.2 4317.2 4256.2 4264.9 4271.6 4288.5 4295.6 4392.5 4410.3 4502.5 4511.4 4532.7 4954.2 4996.2 5001.8 5009.6 5009.9 5025.6 5033.5 5035.8 5036.9 5061.8 4567.1 4590.3 4629.8 4668.9 4679.2 5092.0 5097.1 5108.3 5114.6 5117.8 4699.1 4914.0 4915.5 4915.7 4955.6 4945.4 4973.6 4979.6 5021.5 5027.6 4872.0 4872.2 4872.7 4884.4 4915.0 4816.5 4862.6 4867.1 4906.3 4913.2 4187.1 4204.0 4212.1 4232.8 4247.9 3692.3 3702.3 3708.4 3720.9 3742.4 4224.4 4272.5 4282.9 4285.7 4310.9 4963.6 4970.7 4982.2 4994.0 5020.5 4254.4 4256.7 4258.7 4264.0 4298.8 4402.8 4466.4 4491.8 4492.0 4559.7 4761.8 4765.1 4766.8 4787.6 4789.3 5022.1 5024.3 5024.5 5026.2 5068.1 4631.5 4681.7 4755.1 4755.3 4772.9 4879.2 4887.1 4893.8 4896.4 4940.0 4954.0 4956.5 4958.6 4962.2 5009.7 4574.6 4789.2 4851.3 4886.7 4888.6 4795.9 4800.9 4807.0 4818.3 4871.5 4566.0 4751.3 4752.9 4754.8 4803.9 4748.2 4801.6 4832.9 4836.2 4922.7 4717.5 4722.0 4722.2 4744.6 4756.7 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - PROCESS | 6690 | [#1] ext.html Cycles:180 Average:39741.93 Median:19325.97 stddev:61405.29 (317.7%) stddev-sans-first:61506.98 08:09:25 INFO - PROCESS | 6690 | Values: 532.1 535.9 536.7 548.1 559.1 26977.5 27344.3 27422.3 34551.7 35485.8 41044.4 42000.4 42102.4 42123.8 42191.8 7851.4 8048.6 8053.0 8054.6 8055.5 7752.0 7876.8 7880.1 7881.3 7882.0 7853.5 7880.0 7912.4 7925.0 7929.8 7790.4 7790.7 7820.7 7883.5 7884.9 7813.8 7926.0 7942.3 7942.6 7945.8 38711.4 39484.2 39508.8 39512.4 39538.4 3089.1 3094.8 3105.9 3196.2 3346.1 28625.6 28789.3 28908.3 28959.0 29466.3 3503.8 3505.8 3585.0 3603.5 3604.8 231747.0 231983.8 232186.0 232656.0 233662.0 55860.0 56209.4 56258.2 56304.2 56393.0 60182.4 62356.4 63747.0 63780.4 63799.0 12704.7 12949.4 13138.7 13147.1 13152.1 9879.3 9935.5 9939.5 9972.9 9975.3 19972.1 20309.9 20347.8 20355.8 20400.7 7098.2 7305.8 7441.2 7450.2 7528.7 870.0 888.4 958.9 978.9 980.7 25665.9 26095.7 26452.9 26561.3 26648.2 938.2 953.1 958.2 1027.2 1103.9 13349.5 13646.8 13944.2 13995.9 14065.5 279801.0 284623.0 284641.0 284791.0 285137.0 48107.3 48616.8 48720.5 48745.8 48811.3 996.6 1122.8 1135.9 1191.4 1226.1 24456.4 24500.0 24557.6 24614.8 24650.6 33551.8 33991.8 34447.8 34690.1 34736.8 175812.0 176837.0 176900.0 177263.0 177760.0 31499.4 31997.0 40341.0 40657.4 40848.6 36743.8 36891.0 37003.8 37627.2 37849.0 31642.4 31726.5 33065.8 34138.1 34249.7 33381.7 33585.5 33770.5 33824.0 34242.3 31155.2 32259.8 35146.1 36562.1 36640.3 27377.0 28451.3 28644.3 30347.5 30649.1 23860.2 24724.3 24821.3 26688.2 27814.9 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - PROCESS | 6690 | [#2] jquery.html Cycles:180 Average:23042.63 Median:23968.13 stddev:65077.25 (271.5%) stddev-sans-first:65237.48 08:09:25 INFO - PROCESS | 6690 | Values: 335.2 340.7 345.7 357.3 363.4 14797.9 15315.9 15856.4 15894.7 15936.5 10448.5 10660.8 10705.1 15733.7 15846.4 4302.1 4426.9 4431.1 4432.5 4444.1 4396.9 4417.2 4456.4 4934.8 4946.3 4891.6 4898.0 4909.8 4927.4 4931.7 4539.8 4956.5 4960.3 4966.0 4967.6 4470.0 4483.6 4504.1 4505.7 4508.1 12218.2 12428.2 12435.4 15733.4 19860.5 1856.1 1859.2 1872.7 1905.2 2248.5 9096.8 9220.7 10865.9 11390.4 12726.1 1740.9 1764.7 1800.7 1831.1 1844.9 41966.4 43539.3 55317.2 58056.4 58163.4 8965.2 9296.0 9423.2 9594.6 9643.3 11428.6 11790.2 12110.8 13051.7 13076.0 5648.4 5665.7 5752.8 5768.3 5787.7 5009.8 5054.9 5164.1 5164.2 5166.4 4067.6 4101.5 4124.3 4185.6 4194.9 1703.0 1784.2 1796.5 1820.1 1846.3 869.4 916.2 937.3 946.2 955.0 15327.3 16038.2 16083.8 16122.4 16215.4 940.8 941.5 947.8 955.0 956.8 8972.3 9083.0 9180.6 9353.9 9402.2 366876.0 395908.0 403091.0 403319.0 410366.0 67998.0 71604.6 73822.0 74553.0 75434.0 953.1 972.4 973.8 998.8 998.9 14725.5 14846.6 14894.9 15024.5 15227.7 30858.9 32881.5 33219.3 33473.7 33684.8 46739.0 47629.3 47791.8 47956.5 49312.3 7383.2 7427.5 7463.6 7562.0 7738.5 8904.7 11152.7 11503.7 11520.1 11996.1 9995.7 10238.4 10302.1 10351.1 10394.3 6606.7 9954.8 10023.8 10424.0 10512.6 9986.2 10403.0 10444.1 10548.1 10739.6 7149.9 7353.6 7407.1 7550.2 7653.4 10188.8 10440.4 10449.8 10498.5 10649.5 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - PROCESS | 6690 | [#3] mootools.html Cycles:180 Average:5048.31 Median:5947.54 stddev:2648.86 (44.5%) stddev-sans-first:2641.31 08:09:25 INFO - PROCESS | 6690 | Values: 1300.1 1403.5 1422.3 1547.2 1772.1 6962.4 7141.3 7146.5 7162.2 7165.4 7016.1 7182.0 7187.2 7188.4 7195.7 1877.7 1920.6 1921.1 2183.4 2209.8 2178.5 2250.4 2254.9 2255.3 2256.2 2178.5 2208.2 2214.6 2215.9 2219.4 2160.6 2168.4 2170.7 2171.9 2177.7 2053.2 2083.5 2084.0 2085.7 2086.2 7304.1 7304.3 7343.1 7356.9 7379.0 4200.6 4307.2 4317.4 4318.8 4324.9 2800.6 2829.4 2860.2 2873.7 2901.0 904.9 947.0 952.7 959.6 960.3 9949.2 9950.4 9957.5 9959.5 9978.9 4058.4 4070.9 4130.2 4192.7 4206.7 8541.7 8599.0 8618.2 8620.0 8638.0 4351.0 4370.9 4382.5 4387.3 4388.1 3383.0 3794.9 3930.7 3992.4 3994.9 3382.7 3447.6 3459.3 3476.0 3489.9 1144.2 1187.8 1190.3 1195.7 1205.5 1111.7 1128.4 1136.0 1146.2 1182.3 6651.1 6756.7 6784.9 6791.3 6826.7 455.2 467.1 467.3 469.5 472.8 5086.9 5093.1 5108.4 5135.6 5143.6 8497.9 8575.9 8775.6 8903.5 8919.8 8744.9 8790.4 8812.3 8815.0 8821.6 6640.3 6845.6 6923.0 6972.5 6974.5 6800.6 6830.0 6879.0 6895.0 6895.7 7883.4 7887.8 8068.8 8154.6 8204.4 8153.6 8366.0 8373.1 8415.7 8501.0 5443.4 5886.8 6087.4 6441.6 6550.1 6571.6 6632.3 6662.8 6674.8 6682.9 5771.9 5833.0 5915.4 5921.2 5946.3 5747.3 5779.4 5828.4 5869.6 5948.8 6410.6 6421.8 6568.5 6610.9 6611.3 5990.4 6001.7 6009.9 6023.5 6038.3 6143.1 6155.1 6190.0 6195.3 6243.4 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - PROCESS | 6690 | [#4] prototype.html Cycles:180 Average:4675.72 Median:5370.51 stddev:1388.72 (25.9%) stddev-sans-first:1353.50 08:09:25 INFO - PROCESS | 6690 | Values: 315.2 320.8 327.4 329.1 329.9 5338.9 5377.3 5436.2 5436.2 5438.6 5331.5 5337.4 5350.3 5353.7 5363.7 3996.7 4033.5 4115.3 4120.5 4145.5 4097.9 4122.1 4122.5 4123.9 4159.3 4014.5 4058.4 4101.4 4101.7 4102.2 4060.3 4138.8 4144.2 4152.3 4152.9 3665.6 3676.2 3680.4 3682.2 3687.1 4986.7 4990.2 4994.3 4997.1 5031.9 4830.8 4837.9 4840.5 4841.2 4841.5 5589.5 5631.8 5634.7 5652.7 5657.3 3804.4 4081.4 4081.4 4082.1 4086.1 5862.2 5914.9 5917.0 5922.4 5922.8 3953.5 3954.6 3956.9 3958.9 3965.4 4002.5 4012.7 4013.5 4014.0 4016.9 4615.0 4621.4 4649.2 4652.8 4652.8 5586.8 5590.3 5591.3 5592.5 5601.2 1389.6 1414.9 1441.6 1441.9 1445.9 897.3 938.1 939.4 959.3 966.7 4859.7 4884.2 4911.3 4917.4 4924.3 5757.1 5785.3 5786.3 5787.8 5833.1 4888.7 4899.8 4910.4 4912.0 4916.0 3079.6 3109.9 3110.2 3112.1 3115.2 5479.8 5485.9 5486.1 5486.6 5491.8 5890.3 6072.8 6073.9 6080.1 6084.5 5567.8 5590.8 5601.2 5605.8 5607.9 5854.1 5854.3 5900.9 5903.6 5914.3 5774.7 5789.2 5791.3 5791.3 5796.6 5410.2 5585.6 5593.8 5598.7 5607.6 3928.2 3952.4 3964.2 3966.5 3967.2 5876.4 5877.9 5881.7 5884.4 5889.6 5685.7 5689.2 5693.3 5703.5 5707.2 5667.7 5684.0 5691.0 5692.3 5709.2 5397.5 5595.0 5596.6 5603.8 5620.1 5715.4 5732.5 5742.2 5744.4 5752.7 5589.6 5605.3 5609.0 5610.6 5619.8 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - PROCESS | 6690 | [#5] yui.html Cycles:180 Average:12521.05 Median:46503.42 stddev:14099.12 (30.3%) stddev-sans-first:14110.45 08:09:25 INFO - PROCESS | 6690 | Values: 641.7 752.8 761.2 762.7 787.8 11602.5 11666.5 11707.6 11719.6 11738.2 11580.8 11610.4 11662.1 11686.3 11691.1 629.8 780.1 782.1 808.0 813.0 793.4 805.2 805.6 812.1 812.6 839.7 854.0 856.1 857.6 857.7 662.8 815.9 828.0 837.5 838.8 614.4 617.5 622.6 623.5 624.4 11609.2 11649.1 11654.4 11670.7 11673.1 11914.4 12418.6 12806.1 12906.6 13102.0 9046.8 9370.4 9583.2 9613.4 9728.4 3329.2 3356.5 3375.7 3393.8 3463.6 42039.4 42186.2 42229.4 42591.6 42612.4 9429.5 9456.3 9639.2 9656.3 9862.5 17410.4 17417.8 17431.5 17653.6 17701.6 6514.6 6728.8 6736.6 6747.9 6850.8 3491.0 3523.2 3571.4 3626.3 3632.2 2751.6 2784.6 2788.0 2788.9 2799.4 485.7 502.1 505.4 515.4 517.6 460.0 507.1 544.8 597.1 617.7 7814.5 7843.5 7934.5 8021.6 8254.6 618.9 624.3 624.4 629.8 645.7 3668.9 3698.2 3738.5 3841.7 3860.6 48730.5 49497.8 49993.8 50358.7 50443.7 45347.8 45878.5 46299.8 46374.8 46632.1 40530.6 40755.8 40972.2 41018.4 41446.2 7258.8 7414.4 7462.6 7571.6 7703.5 30485.2 31309.5 32284.2 32562.0 33298.3 38234.6 40292.0 40581.2 40872.4 40917.0 9127.4 9168.8 9314.3 9366.4 10877.1 11258.7 11449.9 11581.5 11859.2 12017.4 10945.1 10962.5 10982.9 11277.2 11282.7 10366.5 10665.0 10813.0 11029.2 11640.2 10596.4 10828.8 10971.8 11067.1 11474.8 7486.4 9540.4 9543.1 9919.3 9968.6 9601.0 9769.8 9770.8 9833.4 9950.5 08:09:25 INFO - PROCESS | 6690 | -------- Summary: end -------- 08:09:25 INFO - PROCESS | 6690 | 08:09:25 INFO - TEST-INFO | 6690: exit 0 08:09:25 INFO - TEST-OK | dromaeo_css | took 1117652ms 08:09:25 INFO - TEST-START | kraken 08:09:25 INFO - operating with platform_type : linux_ 08:09:25 INFO - Initialising browser for kraken test... 08:09:25 INFO - TEST-INFO | started process 6871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GeqHN/profile http://localhost:52955/getInfo.html) 08:09:30 INFO - PROCESS | 6871 | __metrics Screen width/height:1600/1200 08:09:30 INFO - PROCESS | 6871 | colorDepth:24 08:09:30 INFO - PROCESS | 6871 | Browser inner width/height: 1024/697 08:09:30 INFO - PROCESS | 6871 | __metrics 08:09:31 ERROR - PROCESS | 6871 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:09:31 INFO - TEST-INFO | 6871: exit 0 08:09:31 INFO - Browser initialized. 08:09:31 INFO - Running cycle 1/1 for kraken test... 08:09:31 INFO - TEST-INFO | started process 6950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GeqHN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:43 INFO - PROCESS | 6950 | RSS: Main: 154533888 08:09:43 INFO - PROCESS | 6950 | 08:09:46 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52955/tests/kraken/driver.html?testName=audio-beat-detection) 08:09:47 INFO - PROCESS | 6950 | RSS: Main: 196182016 08:09:47 INFO - PROCESS | 6950 | 08:09:49 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52955/tests/kraken/driver.html?testName=audio-dft) 08:09:50 INFO - PROCESS | 6950 | RSS: Main: 186359808 08:09:50 INFO - PROCESS | 6950 | 08:09:53 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52955/tests/kraken/driver.html?testName=audio-fft) 08:09:54 INFO - PROCESS | 6950 | RSS: Main: 170704896 08:09:54 INFO - PROCESS | 6950 | 08:09:56 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52955/tests/kraken/driver.html?testName=audio-oscillator) 08:09:56 INFO - PROCESS | 6950 | RSS: Main: 172310528 08:09:56 INFO - PROCESS | 6950 | 08:09:59 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52955/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:09:59 INFO - PROCESS | 6950 | RSS: Main: 173666304 08:09:59 INFO - PROCESS | 6950 | 08:10:02 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52955/tests/kraken/driver.html?testName=imaging-darkroom) 08:10:03 INFO - PROCESS | 6950 | RSS: Main: 174903296 08:10:03 INFO - PROCESS | 6950 | 08:10:06 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52955/tests/kraken/driver.html?testName=imaging-desaturate) 08:10:07 INFO - PROCESS | 6950 | RSS: Main: 172720128 08:10:07 INFO - PROCESS | 6950 | 08:10:10 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52955/tests/kraken/driver.html?testName=json-parse-financial) 08:10:10 INFO - PROCESS | 6950 | RSS: Main: 173072384 08:10:10 INFO - PROCESS | 6950 | 08:10:12 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52955/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:10:13 INFO - PROCESS | 6950 | RSS: Main: 187166720 08:10:13 INFO - PROCESS | 6950 | 08:10:15 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52955/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:10:15 INFO - PROCESS | 6950 | RSS: Main: 185942016 08:10:15 INFO - PROCESS | 6950 | 08:10:17 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52955/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:10:18 INFO - PROCESS | 6950 | RSS: Main: 196063232 08:10:18 INFO - PROCESS | 6950 | 08:10:20 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:10:21 INFO - PROCESS | 6950 | RSS: Main: 199610368 08:10:21 INFO - PROCESS | 6950 | 08:10:24 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:10:24 INFO - PROCESS | 6950 | RSS: Main: 198758400 08:10:24 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | Cycle 1(1): loaded http://localhost:52955/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52955/tests/kraken/driver.html?testName=ai-astar) 08:10:26 INFO - PROCESS | 6950 | RSS: Main: 260464640 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | __start_tp_report 08:10:26 INFO - PROCESS | 6950 | _x_x_mozilla_page_load 08:10:26 INFO - PROCESS | 6950 | _x_x_mozilla_page_load_details 08:10:26 INFO - PROCESS | 6950 | |i|pagename|runs| 08:10:26 INFO - PROCESS | 6950 | |0;ai-astar;109;113;107;112;111;112;102;112;111;112 08:10:26 INFO - PROCESS | 6950 | |1;audio-beat-detection;168;132;155;169;134;160;156;134;189;138 08:10:26 INFO - PROCESS | 6950 | |2;audio-dft;160;161;162;162;161;161;163;163;161;163 08:10:26 INFO - PROCESS | 6950 | |3;audio-fft;78;77;127;102;77;74;73;112;94;74 08:10:26 INFO - PROCESS | 6950 | |4;audio-oscillator;95;95;138;94;94;95;143;94;94;133 08:10:26 INFO - PROCESS | 6950 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;118;117;117 08:10:26 INFO - PROCESS | 6950 | |6;imaging-darkroom;146;147;145;146;145;146;146;145;148;146 08:10:26 INFO - PROCESS | 6950 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;95;95 08:10:26 INFO - PROCESS | 6950 | |8;json-parse-financial;65;67;65;65;73;65;66;77;63;63 08:10:26 INFO - PROCESS | 6950 | |9;json-stringify-tinderbox;64;65;64;63;64;65;64;63;65;63 08:10:26 INFO - PROCESS | 6950 | |10;stanford-crypto-aes;82;82;83;84;84;83;84;95;83;83 08:10:26 INFO - PROCESS | 6950 | |11;stanford-crypto-ccm;121;118;118;118;127;115;122;119;117;115 08:10:26 INFO - PROCESS | 6950 | |12;stanford-crypto-pbkdf2;144;131;144;146;138;134;141;146;144;144 08:10:26 INFO - PROCESS | 6950 | |13;stanford-crypto-sha256-iterative;68;68;70;69;68;68;68;67;66;66 08:10:26 INFO - PROCESS | 6950 | __end_tp_report 08:10:26 INFO - PROCESS | 6950 | __start_cc_report 08:10:26 INFO - PROCESS | 6950 | _x_x_mozilla_cycle_collect,1178 08:10:26 INFO - PROCESS | 6950 | __end_cc_report 08:10:26 INFO - PROCESS | 6950 | __startTimestamp1459523426656__endTimestamp 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | ------- Summary: start ------- 08:10:26 INFO - PROCESS | 6950 | Number of tests: 14 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.35 (3.0%) stddev-sans-first:3.53 08:10:26 INFO - PROCESS | 6950 | Values: 109.0 113.0 107.0 112.0 111.0 112.0 102.0 112.0 111.0 112.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:158.00 stddev:18.93 (12.0%) stddev-sans-first:19.34 08:10:26 INFO - PROCESS | 6950 | Values: 168.0 132.0 155.0 169.0 134.0 160.0 156.0 134.0 189.0 138.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 08:10:26 INFO - PROCESS | 6950 | Values: 160.0 161.0 162.0 162.0 161.0 161.0 163.0 163.0 161.0 163.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#3] audio-fft Cycles:10 Average:88.80 Median:75.50 stddev:19.10 (25.3%) stddev-sans-first:19.85 08:10:26 INFO - PROCESS | 6950 | Values: 78.0 77.0 127.0 102.0 77.0 74.0 73.0 112.0 94.0 74.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:94.00 stddev:21.18 (22.5%) stddev-sans-first:21.98 08:10:26 INFO - PROCESS | 6950 | Values: 95.0 95.0 138.0 94.0 94.0 95.0 143.0 94.0 94.0 133.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:10:26 INFO - PROCESS | 6950 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 08:10:26 INFO - PROCESS | 6950 | Values: 146.0 147.0 145.0 146.0 145.0 146.0 146.0 145.0 148.0 146.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:10:26 INFO - PROCESS | 6950 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:65.50 stddev:4.53 (6.9%) stddev-sans-first:4.76 08:10:26 INFO - PROCESS | 6950 | Values: 65.0 67.0 65.0 65.0 73.0 65.0 66.0 77.0 63.0 63.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 08:10:26 INFO - PROCESS | 6950 | Values: 64.0 65.0 64.0 63.0 64.0 65.0 64.0 63.0 65.0 63.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.83 (4.6%) stddev-sans-first:3.97 08:10:26 INFO - PROCESS | 6950 | Values: 82.0 82.0 83.0 84.0 84.0 83.0 84.0 95.0 83.0 83.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:118.50 stddev:3.59 (3.0%) stddev-sans-first:3.73 08:10:26 INFO - PROCESS | 6950 | Values: 121.0 118.0 118.0 118.0 127.0 115.0 122.0 119.0 117.0 115.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:144.00 stddev:5.20 (3.6%) stddev-sans-first:5.42 08:10:26 INFO - PROCESS | 6950 | Values: 144.0 131.0 144.0 146.0 138.0 134.0 141.0 146.0 144.0 144.0 08:10:26 INFO - PROCESS | 6950 | 08:10:26 INFO - PROCESS | 6950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 08:10:26 INFO - PROCESS | 6950 | Values: 68.0 68.0 70.0 69.0 68.0 68.0 68.0 67.0 66.0 66.0 08:10:26 INFO - PROCESS | 6950 | -------- Summary: end -------- 08:10:26 INFO - PROCESS | 6950 | 08:10:27 INFO - TEST-INFO | 6950: exit 0 08:10:27 INFO - TEST-OK | kraken | took 61827ms 08:10:27 INFO - SUITE-END | took 1179s 08:10:27 INFO - Completed test suite (00:19:39) 08:10:27 INFO - javascript benchmark 08:10:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.096411737951, 2702.486527559765, 2707.9187624371275, 2720.673519177699, 2749.340158361993, 4498.572635599621, 4602.884927876805, 4615.515370886059, 4627.398438203033, 4631.8610441686715, 4614.907701845961, 4627.167109920213, 4649.69776964497, 4685.461171965217, 4696.412948381452, 4250.319948808191, 4278.465191851019, 4304.784760761965, 4337.848175313865, 4416.050549131936, 4387.758673272952, 4425.402570652969, 4437.733735975836, 4444.533324000982, 4474.306482495218, 4210.221109094828, 4247.299195632717, 4297.8495752648505, 4310.80601372939, 4327.199468098381, 4252.425922500453, 4256.318988961782, 4257.787110644455, 4298.204832106039, 4317.201317756225, 4256.212600668886, 4264.893377665552, 4271.615554600101, 4288.485381754178, 4295.570442955711, 4392.494863090722, 4410.338449232609, 4502.459704835441, 4511.436070491189, 4532.660050496226, 4954.232094025432, 4996.225585034325, 5001.824936127255, 5009.599232061463, 5009.924851127236, 5025.572826309768, 5033.471485494044, 5035.823746168903, 5036.949630503685, 5061.848144555669, 4567.132244873464, 4590.265557510782, 4629.768511574408, 4668.85993420198, 4679.227927391942, 5092.0, 5097.057044446789, 5108.2848401223855, 5114.590832733373, 5117.820876269313, 4699.060187962421, 4913.975430122827, 4915.48387419323, 4915.65590408668, 4955.603551715854, 4945.431275403303, 4973.593088734228, 4979.626528010342, 5021.472745361758, 5027.572656324181, 4872.0, 4872.220444728827, 4872.707637541759, 4884.3650325457465, 4914.975425122851, 4816.470188279286, 4862.621267637767, 4867.075255701406, 4906.288588154697, 4913.164761990471, 4187.078842654611, 4204.033072393367, 4212.094399704079, 4232.830686772556, 4247.893802654897, 3692.316921369555, 3702.2965636528975, 3708.42519409492, 3720.9441858372147, 3742.36379815432, 4224.408582798411, 4272.46594175728, 4282.850100246539, 4285.6785741068925, 4310.892227694333, 4963.5780958618925, 4970.65205435616, 4982.177940639754, 4993.950060499421, 5020.472850350734, 4254.404383386328, 4256.702030857872, 4258.659307255412, 4264.04059086703, 4298.806553705091, 4402.757848318373, 4466.3523789050405, 4491.820327186876, 4491.977540112344, 4559.658025648089, 4761.833335833229, 4765.11845308619, 4766.785494652819, 4787.593054590398, 4789.25766506199, 5022.070916880389, 5024.271480635361, 5024.522670346311, 5026.220935754964, 5068.062408454448, 4631.490536040966, 4681.742504162304, 4755.144074066701, 4755.334253204624, 4772.928406073842, 4879.194932836184, 4887.0714564232685, 4893.7797799099835, 4896.436909755281, 4940.036692844861, 4953.950460495349, 4956.479569645136, 4958.628102892226, 4962.156433406401, 5009.674371166008, 4574.61115805147, 4789.185838407409, 4851.34506841586, 4886.65793394459, 4888.58447031992, 4795.904081918272, 4800.879978000578, 4806.951930480651, 4818.277258411266, 4871.464138944642, 4566.041131362451, 4751.334813126235, 4752.9287060694805, 4754.786034628519, 4803.879903002453, 4748.192807222711, 4801.639877009168, 4832.8791780205775, 4836.202026665561, 4922.704637721748, 4717.481077081587, 4721.952780472151, 4722.197226471577, 4744.620430365493, 4756.7145971241835], "unit": "score", "name": "dojo.html", "value": 4566.9897691955375}, {"lowerIsBetter": false, "replicates": [532.0874699889688, 535.8553190638526, 536.7235873525135, 548.1284757235994, 559.0858945623904, 26977.46045079097, 27344.316392090182, 27422.314442138955, 34551.65448345516, 35485.822570887176, 41044.38433423501, 42000.369994450106, 42102.36846447298, 42123.78938105313, 42191.78904105483, 7851.411144164182, 8048.637811298477, 8053.0, 8054.556999365032, 8055.476394034398, 7752.0, 7876.80307992299, 7880.133185349607, 7881.330086942588, 7882.0, 7853.528788272693, 7880.0, 7912.446128770988, 7925.0, 7929.801754956144, 7790.376769858398, 7790.688372465094, 7820.726274580419, 7883.526988380716, 7884.881726774103, 7813.843723125562, 7925.96037019817, 7942.324902383304, 7942.602869856484, 7945.841083178304, 38711.41932871009, 39484.21031579381, 39508.802455987534, 39512.40731389031, 39538.40692389588, 3089.088718827951, 3094.8297843618593, 3105.8757649693985, 3196.184972831936, 3346.1467325832, 28625.57061644077, 28789.28026799347, 28908.277293067633, 28959.0, 29466.263343416373, 3503.807290599016, 3505.8247087645773, 3585.0499617601095, 3603.4774957631, 3604.7837129772297, 231747.0, 231983.8400808002, 232186.0, 232656.0, 233662.0, 55860.0, 56209.43790562042, 56258.15612765812, 56304.155437668465, 56393.0, 60182.398176018556, 62356.376436235965, 63747.0, 63780.36219637837, 63799.0, 12704.745905081847, 12949.352532373343, 13138.737225255441, 13147.14543554666, 13152.145110567782, 9879.308448408543, 9935.453550054672, 9939.50302484873, 9972.900270997343, 9975.301728878909, 19972.10125544354, 20309.89845050765, 20347.796522034885, 20355.796442035688, 20400.693989590167, 7098.183708873443, 7305.780826575211, 7441.23304439064, 7450.217727138681, 7528.682480565879, 869.9782505437288, 888.4447220487195, 958.9472579008082, 978.9118979291898, 980.67147505585, 25665.87167064153, 26095.73904260971, 26452.8677356612, 26561.33596660099, 26648.20055398341, 938.202527851321, 953.0897992417225, 958.152035448619, 1027.2347101409498, 1103.87857335693, 13349.46602135923, 13646.795298070538, 13944.16335019902, 13995.86004139966, 14065.507707230197, 279801.0, 284623.0, 284641.0, 284791.0, 285137.0, 48107.27839082417, 48616.75691621519, 48720.51279487231, 48745.756271218415, 48811.267830982564, 996.5764550066193, 1122.825961975895, 1135.8580177477816, 1191.4400231890997, 1226.0926914083514, 24456.388590285384, 24500.0, 24557.631635525126, 24614.753852461246, 24650.630240546765, 33551.83224083864, 33991.81028663985, 34447.82776086104, 34690.132746681535, 34736.82631586927, 175812.0, 176837.0, 176900.0, 177263.0, 177760.0, 31499.370012600077, 31997.0, 40341.0, 40657.39013914735, 40848.59151408567, 36743.81628091949, 36891.0, 37003.814980926, 37627.24745505129, 37849.0, 31642.36715265728, 31726.52410213895, 33065.834670826494, 34138.14654633654, 34249.65750342465, 33381.66618333785, 33585.49621755627, 33770.493442597886, 33824.0, 34242.31515369629, 31155.221119471287, 32259.838700806347, 35146.12134696653, 36562.08594785152, 36640.26719465649, 27377.0, 28451.28871778222, 28644.283892902844, 30347.544786827773, 30649.080527584207, 23860.16489422862, 24724.25827225186, 24821.255362339158, 26688.19935401941, 27814.86092569524], "unit": "score", "name": "ext.html", "value": 16818.934716377193}, {"lowerIsBetter": false, "replicates": [335.1587515336505, 340.6559375031218, 345.72169403630085, 357.33000623830316, 363.4257872561353, 14797.92601036996, 15315.923420382896, 15856.445024424147, 15894.682106357866, 15936.521904342859, 10448.477576121202, 10660.78678426431, 10705.14358851292, 15733.685326293496, 15846.445374411898, 4302.096559722462, 4426.889327766799, 4431.069475410168, 4432.490263619693, 4444.133393988173, 4396.912061758763, 4417.182821178077, 4456.420665313504, 4934.777934992916, 4946.2580612908, 4891.559759621633, 4897.975510122445, 4909.7545122743895, 4927.433345165298, 4931.654784165092, 4539.818407263706, 4956.479569645189, 4960.280759289883, 4965.975170124144, 4967.577755890754, 4470.0, 4483.551644835523, 4504.054148628792, 4505.662075344362, 4508.143452743968, 12218.20581662189, 12428.192167509083, 12435.378231088409, 15733.449329273535, 19860.503487412785, 1856.053412759489, 1859.228420205613, 1872.662920674278, 1905.237904838062, 2248.5053288276554, 9096.818063638757, 9220.662766099704, 10865.891341086566, 11390.430478476126, 12726.10917235794, 1740.9216585253694, 1764.7352897065414, 1800.7208882623215, 1831.1393644986836, 1844.8708590398544, 41966.37050444246, 43539.346909796375, 55317.170242445995, 58056.419435805525, 58163.41836581622, 8965.193132617966, 9296.0, 9423.199028082552, 9594.568244429018, 9643.324967252225, 11428.599998999995, 11790.23363481371, 12110.81833772494, 13051.673708157372, 13076.0, 5648.378678345379, 5665.66006039639, 5752.769889204469, 5768.307803063659, 5787.71061446926, 5009.799608015638, 5054.949450505522, 5164.122099243138, 5164.225366195101, 5166.3800343958965, 4067.572904845008, 4101.487314085739, 4124.278251306069, 4185.644220241253, 4194.937075943863, 1703.0122528933189, 1784.1792775323497, 1796.4790210838971, 1820.126339357116, 1846.2799508191815, 869.4392117084572, 916.2349438219028, 937.3251259093441, 946.2382781860531, 954.9952250238844, 15327.310271037608, 16038.198090095682, 16083.758743618855, 16122.435714749927, 16215.432459863849, 940.8212439636447, 941.463365881441, 947.8151760406655, 955.016333176829, 956.7942892278194, 8972.327075469366, 9083.0, 9180.586873590704, 9353.859692104625, 9402.247820174507, 366876.0, 395908.0, 403091.0, 403319.0, 410366.0, 67998.0, 71604.64197678979, 73822.0, 74553.0, 75434.0, 953.113604347963, 972.3533849989677, 973.8344481438314, 998.8451789972565, 998.9001099890098, 14725.484608038667, 14846.628834279229, 14894.925525372304, 15024.549263522113, 15227.695446090795, 30858.919937802068, 32881.506777398834, 33219.33561328808, 33473.665263348026, 33684.83157584196, 46739.0, 47629.28556071592, 47791.76104119457, 47956.5204347952, 49312.260316096006, 7383.15093764224, 7427.480076394817, 7463.626818659154, 7562.0, 7738.458307918617, 8904.73285801427, 11152.665420037412, 11503.712407189552, 11520.078393728314, 11996.100292478273, 9995.70012899614, 10238.385696858213, 10302.124319432933, 10351.120154786928, 10394.324368915995, 6606.735730570724, 9954.800903982024, 10023.849642255225, 10424.009719076676, 10512.57949682004, 9986.151177149733, 10403.0, 10444.112250458797, 10548.050675439248, 10739.624113156002, 7149.857002860018, 7353.632318383952, 7407.111146662435, 7550.169481357156, 7653.387728981779, 10188.847167292348, 10440.37357758537, 10449.791004180026, 10498.527566259383, 10649.467526623794], "unit": "score", "name": "jquery.html", "value": 7629.452155714625}, {"lowerIsBetter": false, "replicates": [1300.1224173682763, 1403.4736973634886, 1422.2959634980682, 1547.1645311531774, 1772.0873750018734, 6962.373386395224, 7141.25016873228, 7146.499745017851, 7162.212156662763, 7165.390941769942, 7016.052832867561, 7182.0, 7187.245339239383, 7188.4249260059205, 7195.712171513133, 1877.6901811201135, 1920.6350793349288, 1921.0970843703437, 2183.3559100065518, 2209.845310828243, 2178.4880553070016, 2250.4036430345973, 2254.88725563722, 2255.3234029790997, 2256.187772401934, 2178.5207254404004, 2208.249195273607, 2214.634585293433, 2215.8670479771267, 2219.3563866478703, 2160.5570857974076, 2168.3820111268215, 2170.6852506386645, 2171.902264398098, 2177.695122682818, 2053.1787285086084, 2083.468715477559, 2083.95832083359, 2085.666293393065, 2086.1655337864822, 7304.123505179413, 7304.342609165201, 7343.118825740945, 7356.889646655304, 7379.0, 4200.6219440250525, 4307.203167414038, 4317.438732964726, 4318.805653745589, 4324.913501729948, 2800.565912283599, 2829.363393236526, 2860.184847318525, 2873.726995935383, 2901.04265592354, 904.9411788233809, 946.9526523673858, 952.6849755095116, 959.6257459590765, 960.2810968366615, 9949.204063674888, 9950.402975821475, 9957.502124893726, 9959.452230127341, 9978.850317245247, 4058.411530328086, 4070.9389359159636, 4130.153318569686, 4192.685548583869, 4206.663466922639, 8541.743747687578, 8599.0, 8618.224359807647, 8620.0, 8638.049814520398, 4350.978245108754, 4370.934435983463, 4382.496012958551, 4387.254166791653, 4388.078503514298, 3383.035834787123, 3794.905127371838, 3930.744501607386, 3992.4210989406374, 3994.8801535953967, 3382.661733826598, 3447.6035255945385, 3459.2562599041325, 3476.0440878758036, 3489.8778542750883, 1144.227646338718, 1187.8158885372782, 1190.3393616542728, 1195.6891208285908, 1205.4756181061266, 1111.7165122893773, 1128.3793913347627, 1135.9659210223706, 1146.1518476327458, 1182.3319824299244, 6651.068850360954, 6756.662166891636, 6784.898226526606, 6791.252962174157, 6826.692798824065, 455.2329325087239, 467.0635376070956, 467.2733898787418, 469.4999825186166, 472.8486884197093, 5086.872828179326, 5093.1341671915125, 5108.361454818148, 5135.6405051646025, 5143.588512919032, 8497.915020849712, 8575.871361929576, 8775.648974040967, 8903.465792052497, 8919.777005574782, 8744.8688269676, 8790.384673072824, 8812.250958668585, 8815.0, 8821.60302786376, 6640.269570347355, 6845.5550389224545, 6923.030775691407, 6972.546784459096, 6974.546654467444, 6800.625965571941, 6830.043793868962, 6878.965605171942, 6894.965525172342, 6895.689693963684, 7883.448158628841, 7887.802804929923, 8068.838623227385, 8154.551499667576, 8204.425690201628, 8153.55155466455, 8365.95817020911, 8373.120822313569, 8415.70545030921, 8500.957495212731, 5443.401225865073, 5886.793962211302, 6087.421694938974, 6441.645709485836, 6550.082988381535, 6571.605703657796, 6632.270450250565, 6662.766803161866, 6674.83312917181, 6682.899756503559, 5771.8557036074435, 5833.0, 5915.40845915405, 5921.171036055042, 5946.316173640087, 5747.339056008445, 5779.364269930388, 5828.417158284307, 5869.589128760946, 5948.762049518144, 6410.647414392253, 6421.8073457796345, 6568.540202185801, 6610.900836487361, 6611.338866113542, 5990.430909063632, 6001.669908155093, 6009.879802404015, 6023.548233882389, 6038.275406951194, 6143.139960405636, 6155.076738489262, 6189.96905015472, 6195.318514963441, 6243.43809057187], "unit": "score", "name": "mootools.html", "value": 4091.0207236974984}, {"lowerIsBetter": false, "replicates": [315.18681800953544, 320.79469139750563, 327.4400774675305, 329.1015527609627, 329.89773170317187, 5338.866528336794, 5377.300950876385, 5436.238926550286, 5436.238926550286, 5438.619296649226, 5331.520163185322, 5337.359516857973, 5350.30446042015, 5353.678779273237, 5363.712708949854, 3996.6802655787615, 4033.495813023372, 4115.32097203961, 4120.546739858613, 4145.523264824554, 4097.89755256118, 4122.093139509303, 4122.546519882811, 4123.9381409278885, 4159.251334759742, 4014.5383280922774, 4058.370952502352, 4101.405296232045, 4101.651359634435, 4102.220578090169, 4060.309747342944, 4138.8344466221315, 4144.150449157915, 4152.294110001307, 4152.875413737593, 3665.6151104134215, 3676.1728611062563, 3680.35593771089, 3682.208325210093, 3687.059799751073, 4986.725730084844, 4990.176620857555, 4994.250862370637, 4997.100521906055, 5031.899362012776, 4830.758462076918, 4837.854864354075, 4840.5159484051665, 4841.2012018016985, 4841.491643377465, 5589.524890384281, 5631.8028868989795, 5634.661920284796, 5652.660840349592, 5657.3494048184575, 3804.353259945816, 4081.3877918312196, 4081.387791831249, 4082.0815316553835, 4086.080631857838, 5862.237909071793, 5914.940850591525, 5916.97041514794, 5922.437368450033, 5922.763089476416, 3953.5058117735284, 3954.6045395460224, 3956.940645890314, 3958.8614398495915, 3965.4250133731025, 4002.4996875390575, 4012.658923991435, 4013.538443079083, 4013.9598604013586, 4016.859409920639, 4615.0, 4621.399218101626, 4649.18639238132, 4652.767361631905, 4652.8135325491785, 5586.804461843816, 5590.273264475592, 5591.30108736408, 5592.496675299242, 5601.243832082617, 1389.6456403617012, 1414.943402263898, 1441.6467965348347, 1441.9134851908918, 1445.9204743739194, 897.2821742605889, 938.0666237094135, 939.3940908114365, 959.3332633819429, 966.6665000574791, 4859.6916464679, 4884.242942343943, 4911.287863259879, 4917.434495033045, 4924.335214745964, 5757.050086735725, 5785.334686511105, 5786.3056433228285, 5787.768489260467, 5833.095870140135, 4888.7311197884455, 4899.779509922062, 4910.386201724785, 4912.042151780369, 4915.992221594564, 3079.5534647475993, 3109.9222519436744, 3110.23799169205, 3112.128603990886, 3115.2367669920563, 5479.75341109651, 5485.945140548623, 5486.067368547357, 5486.588505861996, 5491.780328786804, 5890.322612899486, 6072.757089716361, 6073.939260607337, 6080.118382834465, 6084.513238940963, 5567.832965011056, 5590.804321848797, 5601.243832082617, 5605.775768969195, 5607.915881261784, 5854.121881717606, 5854.297484301911, 5900.940990590039, 5903.616264942765, 5914.3198532167635, 5774.653520788766, 5789.1895134680335, 5791.276090488689, 5791.333996590278, 5796.594238403271, 5410.161424979135, 5585.609007369445, 5593.8321850344555, 5598.664080155204, 5607.635503692411, 3928.2143571285287, 3952.4268980997017, 3964.226975739703, 3966.464527288779, 3967.166894952092, 5876.382979787061, 5877.853053673693, 5881.676507791942, 5884.382139875252, 5889.5582831286965, 5685.744141513725, 5689.1750696148, 5693.3168019837885, 5703.543716502587, 5707.200991861226, 5667.659940403589, 5683.9715801420725, 5691.0, 5692.31692196939, 5709.22925405065, 5397.514223719884, 5595.048841697003, 5596.580256480862, 5603.831885043455, 5620.072688006433, 5715.39988301239, 5732.512736417451, 5742.19609254713, 5744.396838331915, 5752.741126649395, 5589.608727389043, 5605.2713147292225, 5608.971955140199, 5610.6072574921, 5619.80330688424], "unit": "score", "name": "prototype.html", "value": 4232.069230958532}, {"lowerIsBetter": false, "replicates": [641.7433026789283, 752.7892190186748, 761.1551178192205, 762.6529928882352, 787.8188016756146, 11602.477888495017, 11666.533338666464, 11707.590234341811, 11719.648410547676, 11738.178327517067, 11580.826287605672, 11610.419479026035, 11662.125340599447, 11686.305485704588, 11691.123165762581, 629.7921685843684, 780.0989856715503, 782.1201148707704, 807.9919200808005, 812.9715459958873, 793.436659971421, 805.1867613710136, 805.5931754463987, 812.0823469479479, 812.6058861452191, 839.7396806989822, 853.9786505337386, 856.1010938514535, 857.5840717252128, 857.7298151082389, 662.8110988368315, 815.9347252219808, 828.0105274197336, 837.5058715357907, 838.7777239031661, 614.3610644929269, 617.4967401567708, 622.6108682073703, 623.4793947054216, 624.4005754475709, 11609.18735688502, 11649.068074554016, 11654.417279136009, 11670.708232294175, 11673.124515661275, 11914.404279785977, 12418.627441176779, 12806.103572749911, 12906.612801615967, 13102.0, 9046.81906361869, 9370.39092458988, 9583.185429238523, 9613.423194608346, 9728.367656102402, 3329.217633856042, 3356.5133055706788, 3375.729941604666, 3393.830308484566, 3463.619001909788, 42039.36940945888, 42186.17419515847, 42229.366559501635, 42591.57408425907, 42612.3608145878, 9429.528523573794, 9456.338056336128, 9639.18066964302, 9656.27577931658, 9862.45756483386, 17410.39063632792, 17417.780755347256, 17431.477055688098, 17653.558661033578, 17701.55746106332, 6514.609123452608, 6728.831779205559, 6736.562123461959, 6747.865042699119, 6850.760223392157, 3491.0399640099176, 3523.242502861897, 3571.428571428559, 3626.256617393428, 3632.182758879231, 2751.6285301484045, 2784.6240757497885, 2787.958180627292, 2788.930276743057, 2799.3701417180973, 485.65761138397346, 502.11376919736693, 505.44653604303227, 515.3866898390903, 517.6014468859033, 460.0339287496298, 507.0796504344603, 544.779364357428, 597.1401182297478, 617.6880675258966, 7814.492058016211, 7843.529388236724, 7934.484258523177, 8021.558814265271, 8254.628541715638, 618.9199846268291, 624.316373570939, 624.447364082781, 629.7953165221321, 645.7384759172543, 3668.853245870189, 3698.204885949534, 3738.476613274144, 3841.7310788245113, 3860.6294765358457, 48730.53934006986, 49497.75251123722, 49993.75003125034, 50358.748206259464, 50443.747781260856, 45347.77326113348, 45878.54121458743, 46299.768501157276, 46374.76812615915, 46632.06735865264, 40530.594694053274, 40755.7962210187, 40972.1805563893, 41018.38472422916, 41446.1710765783, 7258.818529536804, 7414.406847452083, 7462.589557574385, 7571.583562904093, 7703.499272547267, 30485.23786905345, 31309.53035704421, 32284.19289517781, 32562.0, 33298.33403331968, 38234.61765382422, 40292.0, 40581.18837623172, 40872.386914196904, 40917.0, 9127.406718563272, 9168.816623667355, 9314.34799564024, 9366.438013719198, 10877.12982961377, 11258.662240132482, 11449.885501145216, 11581.536738530365, 11859.22915010556, 12017.399130043637, 10945.124390048617, 10962.451877406258, 10982.890171098186, 11277.210595258253, 11282.66152015408, 10366.5335059924, 10665.040146386862, 10813.0, 11029.172812038969, 11640.185187037165, 10596.364218146937, 10828.783424331627, 10971.835422468828, 11067.059299959594, 11474.827877582009, 7486.401087913063, 9540.379875308083, 9543.093406126407, 9919.256055795988, 9968.60125594997, 9601.0, 9769.804603908024, 9770.80458390814, 9833.4099954003, 9950.502474876082], "unit": "score", "name": "yui.html", "value": 5833.213744398591}], "name": "dromaeo_css", "value": 6242.755272515581}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 113.0, 107.0, 112.0, 111.0, 112.0, 102.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [168.0, 132.0, 155.0, 169.0, 134.0, 160.0, 156.0, 134.0, 189.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 153.5}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 162.0, 161.0, 161.0, 163.0, 163.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 127.0, 102.0, 77.0, 74.0, 73.0, 112.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 138.0, 94.0, 94.0, 95.0, 143.0, 94.0, 94.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 65.0, 65.0, 73.0, 65.0, 66.0, 77.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 63.0, 64.0, 65.0, 64.0, 63.0, 65.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 84.0, 84.0, 83.0, 84.0, 95.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 118.0, 118.0, 127.0, 115.0, 122.0, 119.0, 117.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [144.0, 131.0, 144.0, 146.0, 138.0, 134.0, 141.0, 146.0, 144.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 69.0, 68.0, 68.0, 68.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1522.9}]} 08:10:27 INFO - Return code: 0 08:10:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:10:27 ERROR - # TBPL SUCCESS # 08:10:27 INFO - Running post-action listener: _resource_record_post_action 08:10:27 INFO - Running post-run listener: _resource_record_post_run 08:10:29 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 391872512; Read time: 932; Write time: 517188 08:10:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 74428416; Read time: 496; Write time: 111520 08:10:29 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 280403968; Read time: 436; Write time: 390824 08:10:29 INFO - Running post-run listener: _upload_blobber_files 08:10:29 INFO - Blob upload gear active. 08:10:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:10:29 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 08:10:29 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'] 08:10:29 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 08:10:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:10:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:10:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:10:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:31 INFO - (blobuploader) - INFO - Done attempting. 08:10:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:10:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:10:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:33 INFO - (blobuploader) - INFO - Done attempting. 08:10:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:10:33 INFO - Return code: 0 08:10:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:10:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:10:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/345ab23df130262da5585d3a46b997baa26c4962d786afab2e7ec55d93c5dda977b0342b1d79991a0bcadc0d99c1016d56b5d94ec8bc2487a277f3f25d8a3d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05c9368644830e642e31f6978b48f8e84a015311eb77e6f3c7b137ee4525dc06ff1012b3d49b941bb1680ea43312bb911cc4cde3d76539a0b4a5364346284697"} 08:10:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:10:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:10:33 INFO - Contents: 08:10:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/345ab23df130262da5585d3a46b997baa26c4962d786afab2e7ec55d93c5dda977b0342b1d79991a0bcadc0d99c1016d56b5d94ec8bc2487a277f3f25d8a3d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05c9368644830e642e31f6978b48f8e84a015311eb77e6f3c7b137ee4525dc06ff1012b3d49b941bb1680ea43312bb911cc4cde3d76539a0b4a5364346284697"} 08:10:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:10:33 INFO - Copying logs to upload dir... 08:10:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:10:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.255209 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-04-01 08:10:31.983853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 08:10:31.987611) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 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/345ab23df130262da5585d3a46b997baa26c4962d786afab2e7ec55d93c5dda977b0342b1d79991a0bcadc0d99c1016d56b5d94ec8bc2487a277f3f25d8a3d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05c9368644830e642e31f6978b48f8e84a015311eb77e6f3c7b137ee4525dc06ff1012b3d49b941bb1680ea43312bb911cc4cde3d76539a0b4a5364346284697"} build_url:https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/BReFw_FdR2CwUhuYkLTYCw/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/345ab23df130262da5585d3a46b997baa26c4962d786afab2e7ec55d93c5dda977b0342b1d79991a0bcadc0d99c1016d56b5d94ec8bc2487a277f3f25d8a3d58", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05c9368644830e642e31f6978b48f8e84a015311eb77e6f3c7b137ee4525dc06ff1012b3d49b941bb1680ea43312bb911cc4cde3d76539a0b4a5364346284697"}' ========= master_lag: 0.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 08:10:32.198362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 08:10:32.198710) ========= 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=5bd038846534b2fdfa68eeae000001e2-1459522008.234990-530662695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 08:10:32.439575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 08:10:32.439893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 08:10:32.440226) ========= ========= Total master_lag: 2.30 =========