builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1457821739.41 results: success (0) buildid: 20160312135027 builduid: b9dd6481e12a4b0f9711167cbbff2a5e revision: 90f5e1712c253d06b52edebc08e80a67ba1441bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.413603) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.413995) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.414274) ========= 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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006390 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.470433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.470702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.519050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.519316) ========= 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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.567428) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.567689) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.568017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.568288) ========= 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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-12 14:28:59-- 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% 41.9M=0s 2016-03-12 14:28:59 (41.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165086 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.745405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.745692) ========= 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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013767 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.810428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:28:59.810741) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 90f5e1712c253d06b52edebc08e80a67ba1441bb --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 90f5e1712c253d06b52edebc08e80a67ba1441bb --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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-12 14:28:59,964 truncating revision to first 12 chars 2016-03-12 14:28:59,965 Setting DEBUG logging. 2016-03-12 14:28:59,965 attempt 1/10 2016-03-12 14:28:59,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/90f5e1712c25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-12 14:29:00,302 unpacking tar archive at: fx-team-90f5e1712c25/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:29:00.430443) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 14:29:00.430743) ========= echo 90f5e1712c253d06b52edebc08e80a67ba1441bb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'90f5e1712c253d06b52edebc08e80a67ba1441bb'] 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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 90f5e1712c253d06b52edebc08e80a67ba1441bb program finished with exit code 0 elapsedTime=0.004066 script_repo_revision: '90f5e1712c253d06b52edebc08e80a67ba1441bb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 14:29:00.480159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 14:29:00.480460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 14:29:00.493982) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-03-12 14:29:00.494248) ========= /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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:29:00 INFO - MultiFileLogger online at 20160312 14:29:00 in /builds/slave/test 14:29:00 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 14:29:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:29:00 INFO - {'append_to_log': False, 14:29:00 INFO - 'base_work_dir': '/builds/slave/test', 14:29:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:29:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:29:00 INFO - 'branch': 'Fx-Team-Non-PGO', 14:29:00 INFO - 'buildbot_json_path': 'buildprops.json', 14:29:00 INFO - 'config_files': ('talos/linux_config.py',), 14:29:00 INFO - 'default_actions': ('clobber', 14:29:00 INFO - 'read-buildbot-config', 14:29:00 INFO - 'download-and-extract', 14:29:00 INFO - 'populate-webroot', 14:29:00 INFO - 'create-virtualenv', 14:29:00 INFO - 'install', 14:29:00 INFO - 'run-tests'), 14:29:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:29:00 INFO - 'download_minidump_stackwalk': True, 14:29:00 INFO - 'download_symbols': 'ondemand', 14:29:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:29:00 INFO - 'tooltool.py': '/tools/tooltool.py', 14:29:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:29:00 INFO - '/tools/misc-python/virtualenv.py')}, 14:29:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:29:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:29:00 INFO - 'installer_path': 'installer.exe', 14:29:00 INFO - 'log_level': 'info', 14:29:00 INFO - 'log_name': 'talos', 14:29:00 INFO - 'log_to_console': True, 14:29:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:29:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:29:00 INFO - 'opt_config_files': (), 14:29:00 INFO - 'pip_index': False, 14:29:00 INFO - 'sps_profile': False, 14:29:00 INFO - 'sps_profile_interval': 0, 14:29:00 INFO - 'suite': 'dromaeojs', 14:29:00 INFO - 'system_bits': '32', 14:29:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:29:00 INFO - 'title': 'talos-linux64-ix-015', 14:29:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:29:00 INFO - 'use_talos_json': True, 14:29:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:29:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:29:00 INFO - 'work_dir': 'build'} 14:29:00 INFO - ##### 14:29:00 INFO - ##### Running clobber step. 14:29:00 INFO - ##### 14:29:00 INFO - Running pre-action listener: _resource_record_pre_action 14:29:00 INFO - Running main action method: clobber 14:29:00 INFO - rmtree: /builds/slave/test/build 14:29:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:29:01 INFO - Running post-action listener: _resource_record_post_action 14:29:01 INFO - ##### 14:29:01 INFO - ##### Running read-buildbot-config step. 14:29:01 INFO - ##### 14:29:01 INFO - Running pre-action listener: _resource_record_pre_action 14:29:01 INFO - Running main action method: read_buildbot_config 14:29:01 INFO - Using buildbot properties: 14:29:01 INFO - { 14:29:01 INFO - "project": "", 14:29:01 INFO - "product": "firefox", 14:29:01 INFO - "script_repo_revision": "production", 14:29:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:29:01 INFO - "repository": "", 14:29:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:29:01 INFO - "buildid": "20160312135027", 14:29:01 INFO - "pgo_build": "False", 14:29:01 INFO - "basedir": "/builds/slave/test", 14:29:01 INFO - "buildnumber": 1440, 14:29:01 INFO - "slavename": "talos-linux64-ix-015", 14:29:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:29:01 INFO - "platform": "ubuntu64_hw", 14:29:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:29:01 INFO - "branch": "fx-team", 14:29:01 INFO - "repo_path": "integration/fx-team", 14:29:01 INFO - "revision": "90f5e1712c253d06b52edebc08e80a67ba1441bb", 14:29:01 INFO - "stage_platform": "linux64", 14:29:01 INFO - "builduid": "b9dd6481e12a4b0f9711167cbbff2a5e", 14:29:01 INFO - "slavebuilddir": "test" 14:29:01 INFO - } 14:29:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:29:01 INFO - Running post-action listener: _resource_record_post_action 14:29:01 INFO - ##### 14:29:01 INFO - ##### Running download-and-extract step. 14:29:01 INFO - ##### 14:29:01 INFO - Running pre-action listener: _resource_record_pre_action 14:29:01 INFO - Running main action method: download_and_extract 14:29:01 INFO - mkdir: /builds/slave/test/build/tests 14:29:01 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')]} 14:29:01 INFO - https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:29:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:29:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:29:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:05 INFO - Downloaded 1361 bytes. 14:29:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:29:05 INFO - Using the following test package requirements: 14:29:05 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:29:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:29:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:29:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:05 INFO - u'jsshell-linux-x86_64.zip'], 14:29:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:29:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:29:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:29:05 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:29:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:29:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:29:05 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:29:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:29:05 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')]} 14:29:05 INFO - https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:29:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:29:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:29:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:08 INFO - Downloaded 21981260 bytes. 14:29:08 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'] 14:29:08 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 14:29:10 INFO - Return code: 0 14:29:10 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 14:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:10 INFO - https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:29:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:29:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:29:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:17 INFO - Downloaded 21981260 bytes. 14:29:17 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'] 14:29:17 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 14:29:18 INFO - Return code: 0 14:29: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')]} 14:29:18 INFO - https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:19 INFO - Downloaded 10845263 bytes. 14:29:19 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'] 14:29:19 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 14:29:19 INFO - Return code: 0 14:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:19 INFO - https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:29:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:29:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:29:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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 14:29:21 INFO - Downloaded 54115084 bytes. 14:29:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:29:21 INFO - mkdir: /builds/slave/test/properties 14:29:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:29:21 INFO - Writing to file /builds/slave/test/properties/build_url 14:29:21 INFO - Contents: 14:29:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:29:21 INFO - Running post-action listener: _resource_record_post_action 14:29:21 INFO - Running post-action listener: set_extra_try_arguments 14:29:21 INFO - ##### 14:29:21 INFO - ##### Running populate-webroot step. 14:29:21 INFO - ##### 14:29:21 INFO - Running pre-action listener: _resource_record_pre_action 14:29:21 INFO - Running main action method: populate_webroot 14:29:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:29:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:29:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:29:21 INFO - '--tppagecycles', 14:29:21 INFO - '7'], 14:29:21 INFO - 'tests': ['tsvgm']}}, 14:29:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:29:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:29:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:29:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:29:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:29:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:21 INFO - 'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:29:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:21 INFO - 'tests': ['damp', 'tps']}, 14:29:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:21 INFO - 'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['damp', 'tps']}, 14:29:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:29:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:29:21 INFO - 'other': {'tests': ['a11yr', 14:29:21 INFO - 'ts_paint', 14:29:21 INFO - 'tpaint', 14:29:21 INFO - 'sessionrestore', 14:29:21 INFO - 'sessionrestore_no_auto_restore', 14:29:21 INFO - 'tabpaint']}, 14:29:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['a11yr', 14:29:21 INFO - 'ts_paint', 14:29:21 INFO - 'tpaint', 14:29:21 INFO - 'sessionrestore', 14:29:21 INFO - 'sessionrestore_no_auto_restore', 14:29:21 INFO - 'tabpaint']}, 14:29:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['a11yr', 14:29:21 INFO - 'ts_paint', 14:29:21 INFO - 'tpaint', 14:29:21 INFO - 'sessionrestore', 14:29:21 INFO - 'sessionrestore_no_auto_restore', 14:29:21 INFO - 'tabpaint']}, 14:29:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['a11yr', 14:29:21 INFO - 'ts_paint', 14:29:21 INFO - 'tpaint', 14:29:21 INFO - 'sessionrestore', 14:29:21 INFO - 'sessionrestore_no_auto_restore', 14:29:21 INFO - 'tabpaint']}, 14:29:21 INFO - 'other_l64': {'tests': ['a11yr', 14:29:21 INFO - 'ts_paint', 14:29:21 INFO - 'tpaint', 14:29:21 INFO - 'sessionrestore', 14:29:21 INFO - 'sessionrestore_no_auto_restore', 14:29:21 INFO - 'tabpaint']}, 14:29:21 INFO - 'other_nol64': {'tests': ['a11yr', 14:29:21 INFO - 'ts_paint', 14:29:21 INFO - 'tpaint', 14:29:21 INFO - 'sessionrestore', 14:29:21 INFO - 'sessionrestore_no_auto_restore', 14:29:21 INFO - 'tabpaint']}, 14:29:21 INFO - 'svgr': {'tests': ['tsvgx', 14:29:21 INFO - 'tsvgr_opacity', 14:29:21 INFO - 'tart', 14:29:21 INFO - 'tscrollx', 14:29:21 INFO - 'cart']}, 14:29:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['tsvgx', 14:29:21 INFO - 'tsvgr_opacity', 14:29:21 INFO - 'tart', 14:29:21 INFO - 'tscrollx', 14:29:21 INFO - 'cart']}, 14:29:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:21 INFO - 'tests': ['tp5o']}, 14:29:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:21 INFO - 'talos_options': ['--e10s'], 14:29:21 INFO - 'tests': ['tp5o']}, 14:29:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:21 INFO - 'talos_options': ['--xperf_path', 14:29:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:29:21 INFO - 'tests': ['tp5n']}, 14:29:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:29:21 INFO - 'talos_options': ['--e10s', 14:29:21 INFO - '--xperf_path', 14:29:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:29:21 INFO - 'tests': ['tp5n']}}, 14:29:21 INFO - 'talos.zip': {'path': '', 14:29:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:29:21 INFO - Running post-action listener: _resource_record_post_action 14:29:21 INFO - ##### 14:29:21 INFO - ##### Running create-virtualenv step. 14:29:21 INFO - ##### 14:29:21 INFO - Running pre-action listener: _resource_record_pre_action 14:29:21 INFO - Running main action method: create_virtualenv 14:29:21 INFO - Creating virtualenv /builds/slave/test/build/venv 14:29:21 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 14:29:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:29:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:29:22 INFO - Using real prefix '/usr' 14:29:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:29:22 INFO - Installing distribute.............................................................................................................................................................................................done. 14:29:24 INFO - Installing pip.................done. 14:29:24 INFO - Return code: 0 14:29:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:29:24 INFO - Using env: {'DISPLAY': ':0', 14:29:24 INFO - 'HOME': '/home/cltbld', 14:29:24 INFO - 'LANG': 'en_US.UTF-8', 14:29:24 INFO - 'LANGUAGE': 'en_US:en', 14:29:24 INFO - 'LOGNAME': 'cltbld', 14:29:24 INFO - 'MAIL': '/var/mail/cltbld', 14:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:24 INFO - 'MOZ_NO_REMOTE': '1', 14:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:24 INFO - 'NO_EM_RESTART': '1', 14:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:24 INFO - 'PWD': '/builds/slave/test', 14:29:24 INFO - 'SHELL': '/bin/bash', 14:29:24 INFO - 'SHLVL': '1', 14:29:24 INFO - 'TERM': 'linux', 14:29:24 INFO - 'TMOUT': '86400', 14:29:24 INFO - 'USER': 'cltbld', 14:29:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:24 INFO - '_': '/tools/buildbot/bin/python'} 14:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:24 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 14:29:24 INFO - Cleaning up... 14:29:24 INFO - Return code: 0 14:29:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:29:24 INFO - Using env: {'DISPLAY': ':0', 14:29:24 INFO - 'HOME': '/home/cltbld', 14:29:24 INFO - 'LANG': 'en_US.UTF-8', 14:29:24 INFO - 'LANGUAGE': 'en_US:en', 14:29:24 INFO - 'LOGNAME': 'cltbld', 14:29:24 INFO - 'MAIL': '/var/mail/cltbld', 14:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:24 INFO - 'MOZ_NO_REMOTE': '1', 14:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:24 INFO - 'NO_EM_RESTART': '1', 14:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:24 INFO - 'PWD': '/builds/slave/test', 14:29:24 INFO - 'SHELL': '/bin/bash', 14:29:24 INFO - 'SHLVL': '1', 14:29:24 INFO - 'TERM': 'linux', 14:29:24 INFO - 'TMOUT': '86400', 14:29:24 INFO - 'USER': 'cltbld', 14:29:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:24 INFO - '_': '/tools/buildbot/bin/python'} 14:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:25 INFO - Downloading/unpacking psutil>=0.7.1 14:29: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 14:29: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 14:29: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 14:29: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 14:29: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 14:29: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 14:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:29:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:29:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:29:26 INFO - Installing collected packages: psutil 14:29:26 INFO - Running setup.py install for psutil 14:29:27 INFO - building 'psutil._psutil_linux' extension 14:29:27 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 14:29:27 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 14:29:27 INFO - building 'psutil._psutil_posix' extension 14:29:27 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 14:29:27 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 14:29:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:29:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:29:27 INFO - Successfully installed psutil 14:29:27 INFO - Cleaning up... 14:29:27 INFO - Return code: 0 14:29:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:29: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')]} 14:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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')]} 14:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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', '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 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:29: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 mozsystemmonitor==0.0.0 14:29:27 INFO - Using env: {'DISPLAY': ':0', 14:29:27 INFO - 'HOME': '/home/cltbld', 14:29:27 INFO - 'LANG': 'en_US.UTF-8', 14:29:27 INFO - 'LANGUAGE': 'en_US:en', 14:29:27 INFO - 'LOGNAME': 'cltbld', 14:29:27 INFO - 'MAIL': '/var/mail/cltbld', 14:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:27 INFO - 'MOZ_NO_REMOTE': '1', 14:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:27 INFO - 'NO_EM_RESTART': '1', 14:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:27 INFO - 'PWD': '/builds/slave/test', 14:29:27 INFO - 'SHELL': '/bin/bash', 14:29:27 INFO - 'SHLVL': '1', 14:29:27 INFO - 'TERM': 'linux', 14:29:27 INFO - 'TMOUT': '86400', 14:29:27 INFO - 'USER': 'cltbld', 14:29:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:27 INFO - '_': '/tools/buildbot/bin/python'} 14:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:29: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 14:29: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 14:29: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 14:29: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 14:29: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 14:29: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 14:29:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:29:29 INFO - Installing collected packages: mozsystemmonitor 14:29:29 INFO - Running setup.py install for mozsystemmonitor 14:29:29 INFO - Successfully installed mozsystemmonitor 14:29:29 INFO - Cleaning up... 14:29:29 INFO - Return code: 0 14:29:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:29 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 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29:29 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 14:29:29 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 14:29:29 INFO - Using env: {'DISPLAY': ':0', 14:29:29 INFO - 'HOME': '/home/cltbld', 14:29:29 INFO - 'LANG': 'en_US.UTF-8', 14:29:29 INFO - 'LANGUAGE': 'en_US:en', 14:29:29 INFO - 'LOGNAME': 'cltbld', 14:29:29 INFO - 'MAIL': '/var/mail/cltbld', 14:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:29 INFO - 'MOZ_NO_REMOTE': '1', 14:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:29 INFO - 'NO_EM_RESTART': '1', 14:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:29 INFO - 'PWD': '/builds/slave/test', 14:29:29 INFO - 'SHELL': '/bin/bash', 14:29:29 INFO - 'SHLVL': '1', 14:29:29 INFO - 'TERM': 'linux', 14:29:29 INFO - 'TMOUT': '86400', 14:29:29 INFO - 'USER': 'cltbld', 14:29:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:29 INFO - '_': '/tools/buildbot/bin/python'} 14:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:29:29 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 14:29:29 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 14:29:29 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 14:29:29 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 14:29:29 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 14:29:29 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 14:29:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:29:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:29:31 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 14:29:31 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 14:29:31 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 14:29:31 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 14:29:31 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 14:29:31 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 14:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:29:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:29:32 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 14:29:32 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 14:29:32 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 14:29:32 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 14:29:32 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 14:29:32 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 14:29:32 INFO - Downloading docopt-0.6.1.tar.gz 14:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:29:32 INFO - Installing collected packages: blobuploader, requests, docopt 14:29:32 INFO - Running setup.py install for blobuploader 14:29:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:29:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:29:32 INFO - Running setup.py install for requests 14:29:32 INFO - Running setup.py install for docopt 14:29:33 INFO - Successfully installed blobuploader requests docopt 14:29:33 INFO - Cleaning up... 14:29:33 INFO - Return code: 0 14:29:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:33 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 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29:33 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 14:29:33 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 14:29:33 INFO - Using env: {'DISPLAY': ':0', 14:29:33 INFO - 'HOME': '/home/cltbld', 14:29:33 INFO - 'LANG': 'en_US.UTF-8', 14:29:33 INFO - 'LANGUAGE': 'en_US:en', 14:29:33 INFO - 'LOGNAME': 'cltbld', 14:29:33 INFO - 'MAIL': '/var/mail/cltbld', 14:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:33 INFO - 'MOZ_NO_REMOTE': '1', 14:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:33 INFO - 'NO_EM_RESTART': '1', 14:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:33 INFO - 'PWD': '/builds/slave/test', 14:29:33 INFO - 'SHELL': '/bin/bash', 14:29:33 INFO - 'SHLVL': '1', 14:29:33 INFO - 'TERM': 'linux', 14:29:33 INFO - 'TMOUT': '86400', 14:29:33 INFO - 'USER': 'cltbld', 14:29:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:33 INFO - '_': '/tools/buildbot/bin/python'} 14:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:29:33 INFO - Running setup.py (path:/tmp/pip-SVUy8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:29:33 INFO - Running setup.py (path:/tmp/pip-vUqbZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:29:33 INFO - Running setup.py (path:/tmp/pip-hcXAPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:29:33 INFO - Running setup.py (path:/tmp/pip-eZNfmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:29:33 INFO - Running setup.py (path:/tmp/pip-vbYExN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:29:33 INFO - Running setup.py (path:/tmp/pip-HINPFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:29:33 INFO - Running setup.py (path:/tmp/pip-plPC1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:29:33 INFO - Running setup.py (path:/tmp/pip-rCbHNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:29:33 INFO - Running setup.py (path:/tmp/pip-4tsOv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:29:33 INFO - Running setup.py (path:/tmp/pip-oX6iXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:29:34 INFO - Running setup.py (path:/tmp/pip-jROfKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:29:34 INFO - Running setup.py (path:/tmp/pip-p_sEYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:29:34 INFO - Running setup.py (path:/tmp/pip-0ncV4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:29:34 INFO - Running setup.py (path:/tmp/pip-VUVXPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:34 INFO - Running setup.py (path:/tmp/pip-DhXhUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:29:34 INFO - Running setup.py (path:/tmp/pip-gderXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:29:34 INFO - Running setup.py (path:/tmp/pip-CORIeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:29:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:29:34 INFO - Running setup.py install for manifestparser 14:29:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for mozcrash 14:29:34 INFO - Running setup.py install for mozdebug 14:29:34 INFO - Running setup.py install for mozdevice 14:29:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:29:34 INFO - Running setup.py install for mozfile 14:29:35 INFO - Running setup.py install for mozhttpd 14:29:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Running setup.py install for mozinfo 14:29:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Running setup.py install for mozInstall 14:29:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Running setup.py install for mozleak 14:29:35 INFO - Running setup.py install for mozlog 14:29:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Running setup.py install for moznetwork 14:29:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Running setup.py install for mozprocess 14:29:35 INFO - Running setup.py install for mozprofile 14:29:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Running setup.py install for mozrunner 14:29:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:29:35 INFO - Running setup.py install for mozscreenshot 14:29:36 INFO - Running setup.py install for moztest 14:29:36 INFO - Running setup.py install for mozversion 14:29:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:29:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:29:36 INFO - Cleaning up... 14:29:36 INFO - Return code: 0 14:29:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:36 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 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29:36 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 14:29:36 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 14:29:36 INFO - Using env: {'DISPLAY': ':0', 14:29:36 INFO - 'HOME': '/home/cltbld', 14:29:36 INFO - 'LANG': 'en_US.UTF-8', 14:29:36 INFO - 'LANGUAGE': 'en_US:en', 14:29:36 INFO - 'LOGNAME': 'cltbld', 14:29:36 INFO - 'MAIL': '/var/mail/cltbld', 14:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:36 INFO - 'MOZ_NO_REMOTE': '1', 14:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:36 INFO - 'NO_EM_RESTART': '1', 14:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:36 INFO - 'PWD': '/builds/slave/test', 14:29:36 INFO - 'SHELL': '/bin/bash', 14:29:36 INFO - 'SHLVL': '1', 14:29:36 INFO - 'TERM': 'linux', 14:29:36 INFO - 'TMOUT': '86400', 14:29:36 INFO - 'USER': 'cltbld', 14:29:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:36 INFO - '_': '/tools/buildbot/bin/python'} 14:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:29:36 INFO - Running setup.py (path:/tmp/pip-rOe_RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:29:36 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)) 14:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:29:36 INFO - Running setup.py (path:/tmp/pip-3v4xf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:29:36 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)) 14:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:29:36 INFO - Running setup.py (path:/tmp/pip-13GIdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:29:36 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)) 14:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:29:36 INFO - Running setup.py (path:/tmp/pip-b2ljOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:29:36 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)) 14:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:29:36 INFO - Running setup.py (path:/tmp/pip-K6fJpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:29:36 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)) 14:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:29:36 INFO - Running setup.py (path:/tmp/pip-qTm6Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:29:36 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)) 14:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:29:36 INFO - Running setup.py (path:/tmp/pip-2fMsC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:29:37 INFO - Running setup.py (path:/tmp/pip-grnINq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:29:37 INFO - Running setup.py (path:/tmp/pip-vra0FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:29:37 INFO - Running setup.py (path:/tmp/pip-5ksNII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:29:37 INFO - Running setup.py (path:/tmp/pip-sTklO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:29:37 INFO - Running setup.py (path:/tmp/pip-NFSkmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:29:37 INFO - Running setup.py (path:/tmp/pip-AE0_BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:29:37 INFO - Running setup.py (path:/tmp/pip-IyCd4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:37 INFO - Running setup.py (path:/tmp/pip-w3uLX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:29:37 INFO - Running setup.py (path:/tmp/pip-jaHT4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:29:37 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)) 14:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:29:37 INFO - Running setup.py (path:/tmp/pip-HQnTR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:29:37 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)) 14:29:37 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)) 14:29:37 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)) 14:29:37 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)) 14:29:37 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)) 14:29:37 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)) 14:29:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:39 INFO - Downloading blessings-1.6.tar.gz 14:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:29:39 INFO - Installing collected packages: blessings 14:29:39 INFO - Running setup.py install for blessings 14:29:39 INFO - Successfully installed blessings 14:29:39 INFO - Cleaning up... 14:29:39 INFO - Return code: 0 14:29:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:29:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:40 INFO - Reading from file tmpfile_stdout 14:29:40 INFO - Current package versions: 14:29:40 INFO - argparse == 1.2.1 14:29:40 INFO - blessings == 1.6 14:29:40 INFO - blobuploader == 1.2.4 14:29:40 INFO - docopt == 0.6.1 14:29:40 INFO - manifestparser == 1.1 14:29:40 INFO - mozInstall == 1.12 14:29:40 INFO - mozcrash == 0.17 14:29:40 INFO - mozdebug == 0.1 14:29:40 INFO - mozdevice == 0.48 14:29:40 INFO - mozfile == 1.2 14:29:40 INFO - mozhttpd == 0.7 14:29:40 INFO - mozinfo == 0.9 14:29:40 INFO - mozleak == 0.1 14:29:40 INFO - mozlog == 3.1 14:29:40 INFO - moznetwork == 0.27 14:29:40 INFO - mozprocess == 0.22 14:29:40 INFO - mozprofile == 0.28 14:29:40 INFO - mozrunner == 6.11 14:29:40 INFO - mozscreenshot == 0.1 14:29:40 INFO - mozsystemmonitor == 0.0 14:29:40 INFO - moztest == 0.7 14:29:40 INFO - mozversion == 1.4 14:29:40 INFO - psutil == 3.1.1 14:29:40 INFO - requests == 1.2.3 14:29:40 INFO - wsgiref == 0.1.2 14:29:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:29: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')]} 14:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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')]} 14:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:40 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 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29:40 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 14:29:40 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 14:29:40 INFO - Using env: {'DISPLAY': ':0', 14:29:40 INFO - 'HOME': '/home/cltbld', 14:29:40 INFO - 'LANG': 'en_US.UTF-8', 14:29:40 INFO - 'LANGUAGE': 'en_US:en', 14:29:40 INFO - 'LOGNAME': 'cltbld', 14:29:40 INFO - 'MAIL': '/var/mail/cltbld', 14:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:40 INFO - 'MOZ_NO_REMOTE': '1', 14:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:40 INFO - 'NO_EM_RESTART': '1', 14:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:40 INFO - 'PWD': '/builds/slave/test', 14:29:40 INFO - 'SHELL': '/bin/bash', 14:29:40 INFO - 'SHLVL': '1', 14:29:40 INFO - 'TERM': 'linux', 14:29:40 INFO - 'TMOUT': '86400', 14:29:40 INFO - 'USER': 'cltbld', 14:29:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:40 INFO - '_': '/tools/buildbot/bin/python'} 14:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 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)) 14:29:40 INFO - Cleaning up... 14:29:40 INFO - Return code: 0 14:29:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:29: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')]} 14:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29: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')]} 14:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:40 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 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29:40 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 14:29:40 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 14:29:40 INFO - Using env: {'DISPLAY': ':0', 14:29:40 INFO - 'HOME': '/home/cltbld', 14:29:40 INFO - 'LANG': 'en_US.UTF-8', 14:29:40 INFO - 'LANGUAGE': 'en_US:en', 14:29:40 INFO - 'LOGNAME': 'cltbld', 14:29:40 INFO - 'MAIL': '/var/mail/cltbld', 14:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:40 INFO - 'MOZ_NO_REMOTE': '1', 14:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:40 INFO - 'NO_EM_RESTART': '1', 14:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:40 INFO - 'PWD': '/builds/slave/test', 14:29:40 INFO - 'SHELL': '/bin/bash', 14:29:40 INFO - 'SHLVL': '1', 14:29:40 INFO - 'TERM': 'linux', 14:29:40 INFO - 'TMOUT': '86400', 14:29:40 INFO - 'USER': 'cltbld', 14:29:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:40 INFO - '_': '/tools/buildbot/bin/python'} 14:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:40 INFO - Downloading/unpacking jsonschema 14:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:29:42 INFO - Downloading/unpacking functools32 (from jsonschema) 14:29:42 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 14:29:42 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 14:29:42 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 14:29:42 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 14:29:42 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 14:29:42 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 14:29:42 INFO - Downloading functools32-3.2.3-2.tar.gz 14:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:29:42 INFO - warning: no files found matching '*.txt' 14:29:42 INFO - no previously-included directories found matching 'build' 14:29:42 INFO - no previously-included directories found matching 'dist' 14:29:42 INFO - no previously-included directories found matching '.git*' 14:29:42 INFO - Installing collected packages: jsonschema, functools32 14:29:42 INFO - Running setup.py install for functools32 14:29:42 INFO - warning: no files found matching '*.txt' 14:29:42 INFO - no previously-included directories found matching 'build' 14:29:42 INFO - no previously-included directories found matching 'dist' 14:29:42 INFO - no previously-included directories found matching '.git*' 14:29:42 INFO - Successfully installed jsonschema functools32 14:29:42 INFO - Cleaning up... 14:29:42 INFO - Return code: 0 14:29:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:29:42 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 0x7f52542aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, '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': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', '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 14:29:42 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 14:29:42 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 14:29:42 INFO - Using env: {'DISPLAY': ':0', 14:29:42 INFO - 'HOME': '/home/cltbld', 14:29:42 INFO - 'LANG': 'en_US.UTF-8', 14:29:42 INFO - 'LANGUAGE': 'en_US:en', 14:29:42 INFO - 'LOGNAME': 'cltbld', 14:29:42 INFO - 'MAIL': '/var/mail/cltbld', 14:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:42 INFO - 'MOZ_NO_REMOTE': '1', 14:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:29:42 INFO - 'NO_EM_RESTART': '1', 14:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:42 INFO - 'PWD': '/builds/slave/test', 14:29:42 INFO - 'SHELL': '/bin/bash', 14:29:42 INFO - 'SHLVL': '1', 14:29:42 INFO - 'TERM': 'linux', 14:29:42 INFO - 'TMOUT': '86400', 14:29:42 INFO - 'USER': 'cltbld', 14:29:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:42 INFO - '_': '/tools/buildbot/bin/python'} 14:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:29:42 INFO - Downloading/unpacking flake8 14:29:42 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 14:29:42 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 14:29:42 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 14:29:42 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 14:29:42 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 14:29:42 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 14:29:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:29:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:29:44 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 14:29:44 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 14:29:44 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 14:29:44 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 14:29:44 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 14:29:44 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 14:29:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:29:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:29:44 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 14:29:44 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 14:29:44 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 14:29:44 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 14:29:44 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 14:29:44 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 14:29:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:29:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:29:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:29:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:29:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:29:45 INFO - no previously-included directories found matching 'docs/_build' 14:29:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:29:45 INFO - Running setup.py install for pep8 14:29:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:29:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:29:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:29:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:29:45 INFO - no previously-included directories found matching 'docs/_build' 14:29:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:29:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:29:45 INFO - Cleaning up... 14:29:45 INFO - Return code: 0 14:29:45 INFO - Running post-action listener: _resource_record_post_action 14:29:45 INFO - Running post-action listener: _start_resource_monitoring 14:29:45 INFO - Starting resource monitoring. 14:29:45 INFO - ##### 14:29:45 INFO - ##### Running install step. 14:29:45 INFO - ##### 14:29:45 INFO - Running pre-action listener: _resource_record_pre_action 14:29:45 INFO - Running main action method: install 14:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:29:45 INFO - Reading from file tmpfile_stdout 14:29:45 INFO - Detecting whether we're running mozinstall >=1.0... 14:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:29:46 INFO - Reading from file tmpfile_stdout 14:29:46 INFO - Output received: 14:29:46 INFO - Usage: mozinstall [options] installer 14:29:46 INFO - Options: 14:29:46 INFO - -h, --help show this help message and exit 14:29:46 INFO - -d DEST, --destination=DEST 14:29:46 INFO - Directory to install application into. [default: 14:29:46 INFO - "/builds/slave/test"] 14:29:46 INFO - --app=APP Application being installed. [default: firefox] 14:29:46 INFO - mkdir: /builds/slave/test/build/application 14:29:46 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'] 14:29:46 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 14:30:01 INFO - Reading from file tmpfile_stdout 14:30:01 INFO - Output received: 14:30:01 INFO - /builds/slave/test/build/application/firefox/firefox 14:30:01 INFO - Running post-action listener: _resource_record_post_action 14:30:01 INFO - ##### 14:30:01 INFO - ##### Running run-tests step. 14:30:01 INFO - ##### 14:30:01 INFO - Running pre-action listener: _resource_record_pre_action 14:30:01 INFO - Running main action method: run_tests 14:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:30:01 INFO - Python 2.7.3 14:30:01 INFO - Return code: 0 14:30:01 INFO - grabbing minidump binary from tooltool 14:30:01 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')]} 14:30:01 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 0x2635160>, '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 0x2636060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26364f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:30:01 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 14:30:01 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 14:30:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:30:01 INFO - Return code: 0 14:30:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:30:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:30:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:30:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:30:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:30:02 INFO - Return code: 0 14:30:02 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/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 14:30:02 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/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 14:30:02 INFO - Using env: {'DISPLAY': ':0', 14:30:02 INFO - 'HOME': '/home/cltbld', 14:30:02 INFO - 'LANG': 'en_US.UTF-8', 14:30:02 INFO - 'LANGUAGE': 'en_US:en', 14:30:02 INFO - 'LOGNAME': 'cltbld', 14:30:02 INFO - 'MAIL': '/var/mail/cltbld', 14:30:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:30:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:30:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:30:02 INFO - 'MOZ_NO_REMOTE': '1', 14:30:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:30:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:30:02 INFO - 'NO_EM_RESTART': '1', 14:30:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:30:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:30:02 INFO - 'PWD': '/builds/slave/test', 14:30:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:30:02 INFO - 'SHELL': '/bin/bash', 14:30:02 INFO - 'SHLVL': '1', 14:30:02 INFO - 'TERM': 'linux', 14:30:02 INFO - 'TMOUT': '86400', 14:30:02 INFO - 'USER': 'cltbld', 14:30:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613', 14:30:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:30:02 INFO - '_': '/tools/buildbot/bin/python'} 14:30:02 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/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 14:30:02 INFO - mozversion application_buildid: 20160312135027 14:30:02 INFO - mozversion application_changeset: 90f5e1712c253d06b52edebc08e80a67ba1441bb 14:30:02 INFO - mozversion application_display_name: Nightly 14:30:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:30:02 INFO - mozversion application_name: Firefox 14:30:02 INFO - mozversion application_remotingname: firefox 14:30:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:30:02 INFO - mozversion application_vendor: Mozilla 14:30:02 INFO - mozversion application_version: 48.0a1 14:30:02 INFO - mozversion platform_buildid: 20160312135027 14:30:02 INFO - mozversion platform_changeset: 90f5e1712c253d06b52edebc08e80a67ba1441bb 14:30:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:30:02 INFO - mozversion platform_version: 48.0a1 14:30:02 INFO - using testdate: 1457821802 14:30:02 INFO - actual date: 1457821802 14:30:02 INFO - starting webserver on 'localhost:36110' 14:30:02 INFO - SUITE-START | Running 2 tests 14:30:02 INFO - TEST-START | dromaeo_css 14:30:02 INFO - operating with platform_type : linux_ 14:30:02 INFO - Initialising browser for dromaeo_css test... 14:30:02 INFO - TEST-INFO | started process 17945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExT0I6/profile http://localhost:36110/getInfo.html) 14:30:07 INFO - PROCESS | 17945 | __metrics Screen width/height:1600/1200 14:30:07 INFO - PROCESS | 17945 | colorDepth:24 14:30:07 INFO - PROCESS | 17945 | Browser inner width/height: 1024/697 14:30:07 INFO - PROCESS | 17945 | __metrics 14:30:08 ERROR - PROCESS | 17945 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:30:08 INFO - TEST-INFO | 17945: exit 0 14:30:08 INFO - Browser initialized. 14:30:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:30:08 INFO - TEST-INFO | started process 18037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExT0I6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:20 INFO - PROCESS | 18037 | RSS: Main: 153698304 14:30:20 INFO - PROCESS | 18037 | 14:31:12 INFO - PROCESS | 18037 | 1457821872039 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] 14:33:23 INFO - PROCESS | 18037 | Cycle 1(1): loaded http://localhost:36110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36110/tests/dromaeo/cssquery-ext.html) 14:33:24 INFO - PROCESS | 18037 | RSS: Main: 227426304 14:33:24 INFO - PROCESS | 18037 | 14:36:26 INFO - PROCESS | 18037 | Cycle 1(1): loaded http://localhost:36110/tests/dromaeo/cssquery-ext.html (next: http://localhost:36110/tests/dromaeo/cssquery-jquery.html) 14:36:27 INFO - PROCESS | 18037 | RSS: Main: 239693824 14:36:27 INFO - PROCESS | 18037 | 14:39:29 INFO - PROCESS | 18037 | Cycle 1(1): loaded http://localhost:36110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36110/tests/dromaeo/cssquery-mootools.html) 14:39:29 INFO - PROCESS | 18037 | RSS: Main: 246018048 14:39:29 INFO - PROCESS | 18037 | 14:42:31 INFO - PROCESS | 18037 | Cycle 1(1): loaded http://localhost:36110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36110/tests/dromaeo/cssquery-prototype.html) 14:42:32 INFO - PROCESS | 18037 | RSS: Main: 222588928 14:42:32 INFO - PROCESS | 18037 | 14:45:35 INFO - PROCESS | 18037 | Cycle 1(1): loaded http://localhost:36110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36110/tests/dromaeo/cssquery-yui.html) 14:45:35 INFO - PROCESS | 18037 | RSS: Main: 207282176 14:45:35 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | Cycle 1(1): loaded http://localhost:36110/tests/dromaeo/cssquery-yui.html (next: http://localhost:36110/tests/dromaeo/cssquery-dojo.html) 14:48:38 INFO - PROCESS | 18037 | RSS: Main: 257282048 14:48:38 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | __start_tp_report 14:48:38 INFO - PROCESS | 18037 | _x_x_mozilla_page_load 14:48:38 INFO - PROCESS | 18037 | _x_x_mozilla_page_load_details 14:48:38 INFO - PROCESS | 18037 | |i|pagename|runs| 14:48:38 INFO - PROCESS | 18037 | |0;dojo.html;2559.0502082657817;2627.106783693544;2635.0250407349286;2641.7490338417842;2662.108193755092;4568;4582.335561343603;4591.678582499227;4596.885077873055;4621.445426548818;4628.4677262114865;4657.2082745933185;4683.274092515657;4690.5074967128385;4699.248120300753;4306.61240488356;4311.267084595618;4317;4329.826806927719;4460.286354183331;4240.342746874224;4389.056352884129;4397.032652816391;4430.867073987785;4445.866624001269;4255.5318914919335;4309.439772829513;4318.740875547462;4329.567043295677;4338.501072376685;4229.957700423018;4238.470191226097;4267.786610669454;4273.166732487166;4325.82696692132;4204.2432362174795;4212.220739163234;4218.641415479688;4235.809388577491;4245.511766146902;4459.598636122764;4547.45430548333;4597.034622729231;4613.446386433616;4633.027064316498;4855.562999330077;4891.559759621616;4896.730679812609;4901.387326584177;4911.557959783601;4916.754162291871;4920.434150072751;4925.26121081837;4932.112219800434;4941.703497790144;4569.360289559464;4641.6286697063815;4667.813287468463;4711.246200607886;4717.198076327033;4975.477574854661;4989.027139707722;4992.104579343972;4992.350994370709;4995.250712393097;4788.784504697297;4793.113274044313;4794.041191761662;4803.447603525639;4839.395075615548;4932.53140951609;4973.776180071905;4977.502249774993;5010.574101201366;5016.498350165028;4843.418789745253;4891.657583969088;4938.4320803107385;4950.356453661001;4968.950310496921;4795.976020119877;4836.105320515716;4907.55831975124;4926.285688575136;4985.501449854985;4241.321388577812;4250.596193361687;4253.532111467736;4267.487901451846;4305.612494875476;3681.079730067483;3683.9447408288897;3685.8894233173046;3686.1337585667347;3731.402975523903;4241.088166044316;4250.723702959298;4264.7654379009455;4269.530351661315;4308.913821723548;4931.284963680247;4964.90070198594;4965.9751701241985;5003.799848006039;5018.121828679967;4280.764557949343;4283.421738065384;4287.849925252601;4331.610155085994;4332;4451.3323001550025;4492.505824359318;4532.818687252539;4534.387857639176;4534.523874993144;4702.835400760957;4703.3885594872445;4722.693024953367;4734.715917044989;4767.880802979953;5004.624653150955;5005.374328208974;5009.448960614257;5018.4981501849525;5045.041442125985;4590;4638.165130276448;4689.155951928549;4718.292256161603;4762.904741905073;4870.488598697228;4897.41231052276;4899.510048995072;4937.8271760488215;4947;4966.577840883565;4968;4969.527894849984;4969.818612105617;5005.549500544968;4709.599684026759;4835.8065677372515;4842.612590992782;4883.536064073907;4908.386451693538;4850.660453768202;4864.294677271847;4896.069746748107;4902.068606964665;4936.8765780855765;4794.856154315376;4803.495632958489;4811.109944660249;4822.300766388924;4868.464468908488;4760.523947605212;4872.902541949212;4905.166121759238;4920.188168952082;4952.950470495249;4796.400449943757;4804.591609713214;4814.277858321279;4821.108095002436;4872.439669437918 14:48:38 INFO - PROCESS | 18037 | |1;ext.html;544.5561867078328;551.1925029831298;567.1634339349457;569.9686517241553;579.6000759475961;28117.859410702942;35101.47347789782;35447.64552354476;35532.11169720755;35542.46686299701;39188.80405597968;39575.80212098943;39658.8017059915;39687;39708.20583588334;7768.223177682229;7931.365490760725;7973.920260797405;7976.481528700616;7980.324131932272;7834.334081603042;7952.165022672622;7962.124166341698;7963.800904977393;8162.183781621849;8121.959390203041;8210.876836847452;8210.917890821105;8213.630386632585;8216.630251638691;8054.758357249292;8111.634976426075;8139.593020348959;8143.552104634243;8146.144654811219;7928.127905930343;8028.919710802876;8047.637856296422;8052.396070294692;8053.798655033671;38694.80652596747;39149.60850391488;39164.412533812014;39209.21581568353;39242.60757392418;3271.96728032719;3339.682730140657;3340.1482621931495;3387;3883;28833.27916802076;29376.26559336034;29505.852470737507;29711;30569.541456878163;3431.9142021449666;3453.689167974869;3475.2528206435736;3497.615262321143;3528.752987290891;257375;258485;258863;259005.9999999981;259071.9999999981;43526.12947741027;44119.77940110279;58131.41868581345;58149.4185058144;58525.122123168185;42348.3647745284;42456;42491;42560;42596;14320.57038288853;14516.056456330305;14519.92740036293;14529;14530.273486325641;11584.76830463386;11589.420528973518;11654.941725291319;11659;11668.066554675775;14279.500217492337;14883.627909302137;14956.102633842005;14998.500149985133;15064.472743453927;5877.265341832271;5961.493273071751;6018.759249629966;6042.758289668452;6046.818595442144;825.0347093900151;847.8080028691979;885.3625389719392;920.3373571028849;952.8570714392896;26938.32654183661;28004.875583434892;28036.43927121446;28200.71799282022;28208.29479262994;958.1568219966385;986.3687240166299;987.5950860147306;993.101243374747;1050.2753100360726;13840.23878686682;14770.187639679922;15445.382184712485;16247.593810154603;16411;378413;383484;383741;383919;384345;51980.220296694824;52527;52531.73734131305;52541;52740.73629631904;1087.853139826129;1205.921615095016;1273.242420759628;1289.239348784203;1386.0090035624578;24980.87509562513;25880.61179082353;25957.154518485862;25993.350166245997;28137.155885323475;39425.21149576935;39663.2067358657;39940.800295998335;39958;40011.399829002;189755.051224743;190043;202490;203791;204252;28813.27966800847;32849.34301314008;33920.321593567496;34003.42963988746;34156.14609634779;38186.236275274896;38462.42306365351;38734.80632596819;39145.41281880831;39262.60737392589;32351.35297294088;33440.832795835864;33992;34068.318633626695;34156.658433415345;33222.83388583042;33395.66604333925;33569.49645755267;33670;34210;33406.66593334036;34196.65803341935;34235.657643424245;34515.13712157216;34520;29449.11652650424;30045.399092018473;30385;30454.54318185185;30633.387332252783;22957.426064348525;23034.53930921406;23482.88258558696;23633;23648.52702945966 14:48:38 INFO - PROCESS | 18037 | |2;jquery.html;355.08034191444153;359.40339037198254;363.15566308333126;368.3241252302026;369.7208607501336;15481.767773483392;15617.687646247068;16791.496255112364;16807.243674034667;16891.324347026133;15733.685326293467;16152.919235403835;16373.918130409362;16397.524222819942;16416.589585260375;4825.10735513931;4865.951340486586;4990.87522811929;4993.300937868701;4997.5252351026775;3678.3011227866755;5534.861628459281;5806.738696758656;5809.01246788045;5810.244668193129;5750.252467179261;5754.99287624664;5763.337216220126;5775.682337471459;5778.59549831512;5613.550915926737;5709.31488221414;5749.367569567345;5760.654360738327;5819.912701309484;5041.621878359138;5056.6713163644245;5060.089183946888;5061.645684802065;5064.164412871872;18166.364177253734;19021.14404851771;19124.80875191258;19146.425607231806;19162;2004.0681083296338;2019.848511361639;2022.2921977307972;2193.484531135182;2353.6116540770754;11398.430078496041;11918;12470.376481175996;12769;12836.294003829786;1684.4188754879547;1755.806861245262;1909.6849019911697;1998.270631219609;2020.3938818354434;55027.17459238115;55541.1668824972;55838;57010.42989570092;62064.68967655178;9500.572474238537;9841.065098815601;9973.80052398948;9982.401055936667;10059.044390782863;12737.808932866015;12742.745145097046;12815.295158766357;12882.742345153045;12892.033097517537;7244.311790379906;7423.48035637511;7472.028636277358;7530.096388433423;7541.095068591804;7156;7231.168415632164;7316.487845850739;7324.780256592311;7394.260573942563;4297.484301883794;4402.229609818269;4408.448943882015;4409.669274804402;4411.316245981878;1699.6855581717423;1761.6564769870008;1762.5505496098413;1807.6746185686702;1812.2479171144091;825.9091499935003;857.8756080368312;931.0689310689311;949.8907625623003;992.528548939248;14303.64240893986;14628.341724622418;14919.850801491846;15372.615684607974;15473.381064757508;875.3303722652176;903.2503022491317;969.5927710361665;975.2636759246865;987.4914419074182;8921.821563568692;8942.061083586259;8968.282537396992;9000.424925637988;9185.402948808307;375746;382118;390627;393616;394178;67439.66280168567;72072;72074;72224.63887680529;74113.5177296451;928.2481190235931;935.2658163341744;951.9333646644807;953.2659851913987;956.6269155029405;13851.16892986424;14109.929450352682;14126.293685315899;14205;14420.134791912518;33464.33071338608;34222.14444638904;34488.82755586206;34905.30189396249;35369;46160.769196155146;48854;48906.75546622244;49513.75243123761;49617.751911240215;7260.782176534713;7362.263773622595;7370.189279179179;7393.112826460859;7473.925260747323;6280.309165991646;8734.388592798443;9417.340786144903;9746.635471034202;10949;9193.678221262224;9255;9637.807243854942;9803.754906127404;9822.5088745561;9502.429854208769;9531.952340238255;9592.472414017016;9697.563609637442;9771.80456390854;4916.139675556692;6345.682715864281;9060.459721847434;9631.08504692053;10335.483225838829;6899.413549848319;7393.112826460859;7492.587907664913;7529.209433009455;7710.575918324322;7946.8807967879375;9740.172085372822;10050.396976181453;10199.59201631956;10286.794264114826 14:48:38 INFO - PROCESS | 18037 | |3;mootools.html;1318.8747069028439;1414.363536408616;1422.805800976807;1582.5885269829848;1779.1993602878708;6807.285235050316;6971.372576468123;6980.092587963558;6986;6988.056612357336;7098.183708873481;7255.455840811934;7267.018952441419;7273.490855640107;7280.526765760222;1830.9267629294811;1875.634251320993;2158.4064382294837;2208.138825857917;2235.619944609412;2162.0703097667997;2165.545235500539;2167.241465487075;2167.4581354661336;2168.5120847809194;2109.831213502916;2119.1417475922276;2126.5959467701164;2217.2239716099316;2227.27613525604;2172.3374370816896;2184.4648061224943;2187.639039558471;2191;2191.901364438604;2196.0556960506974;2208.6134926387977;2211.8562293450873;2212.7676593957563;2214.30249471416;7411.777646670608;7466.552006879605;7470.47706660534;7475.252474752536;7484.064491938508;4489.46126464823;4560.338750881137;4572.245579479382;4601.3558101865765;4604.7927843247135;2789.3445040415486;2930.1832863624477;2937.6915423880614;2958.5266357382716;2968.3469636679897;936.6440752514069;944.8157609266195;949.7530642033121;970.6166064404591;994.6866736977829;10111.696649100539;10119.190464762802;10125.797484050352;10132.138768204637;10133.645322413753;4067.206894655573;4149.33610622299;4153.958460415357;4168.374743788456;4191.1827193697545;8687.782805429915;8694.782630434163;8702.347323950602;8704.086070962585;8713.564321783886;4505.053938672915;4511.70673906195;4530.365748795171;4531.77341132942;4539.251023581138;3652.7077833773233;3693.7045036397026;4013.57857424972;4094.61101195386;4125.401816736557;3544.929101417957;3551.4317709166926;3611;3622.4385220290897;3626.220362622049;1158.1198289300191;1204.6325870609548;1215.4955693387321;1224.9938750306192;1225.4914210602678;1013.7516308504316;1026.1277913773233;1035.5857656937285;1116.1349953785882;1250.1374051904156;7072.858542829217;7083.291670832876;7091.290870912971;7109.395701365442;7123.572585644878;1107.0755918807886;1131.4719007937952;1138.1861968692424;1163.6160067177811;1167.2821214952912;5465.180222966586;5477.068898287301;5503.862403439866;5518.172274158908;5530.364008139116;8549.444286121383;8649.956750216208;8793.03276639569;8805.69180078694;8922.286217102615;8999.730008099768;9249.815003700023;9256.259499240045;9257.166854983085;9283.257339412965;6865.656717164122;6895.34494223048;7083.433325333961;7098.077249957576;7098.716051357887;7020.227774944854;7111.82220444493;7130.322619351154;7148.28517148281;7183.497155199086;8007.959960200162;8119.30985866208;8163.142869998802;8199.508029518249;8350.958245208734;8251.2986396157;8581.442206256574;8685.739427817176;8789.736307910773;8794;5706.28671416073;6138.478229350555;6260.906086408799;6586.077949087035;6677.499187560855;6835.453163746789;6916.412104970933;6927.89608155868;6954.3393377629045;6958.095447591781;6107.857722141247;6320.873582528416;6365.458935990493;6489.1888513935755;6499.1876015498065;6087.66517841523;6136.23297087864;6227.626342419469;6298.779542715983;6404.199475065617;6625.436837868835;6666.366695163952;6675.933240667726;6700.83247918806;6703.3296670332575;5849.766009359748;6106.755729770759;6155.1382806406245;6164.938350616437;6166.475849552839;5952.553558483044;6006.819795406145;6023.036314189709;6027.065804800263;6027.457528822251 14:48:38 INFO - PROCESS | 18037 | |4;prototype.html;312.6529552197061;313.7631088528161;316.18266780372727;318.3330921719001;318.6781350835657;5332.413434522199;5465.50810427062;5484.204790305408;5498.4501549845;5527.751251193696;5321.840344789653;5437.510624043835;5450.972745136279;5451.37309209441;5451.563874889999;3903.5315762108585;4041.959580404188;4163.75017498951;4186.518550366716;4192.895177620569;4165.83336666533;4175.498940127174;4180.163967206571;4183.62347388735;4185.100203456256;4117.794110294488;4123.154753275571;4128.256913755523;4131.8553850615235;4138.544760076389;3886.436466712325;3995.880123596268;4108;4124.154548317618;4131.710780245384;3550.04148879801;3563.518924945125;3570.9821450892578;3574.4995700601935;3577.6422357764013;5114.053900028507;5145.819896303648;5149.201873709581;5150.510701483353;5160.974195129038;4743.430788305391;4750.12122757291;4755.619550435957;4755.785989630475;4758.666893317469;5692.487676109128;5698.601097923147;5699.886002279931;5710.229119068914;5720.399358067385;3901.2197560487734;3908.609139086097;3919.863239660495;3930;3930.2925473414775;5768.826935191909;5930.733117009701;6098.9695051524905;6101.725422356005;6121.326654068093;3958.9010274742786;3971.3050216212046;3981.6814654827544;3986.920261594752;3992.301347264217;4038.353863381845;4041.8787436376956;4042.0905296308097;4044.6359827615656;4047.170330082326;4703.482616912137;4706.576408123216;4709.882252943704;4713.010267843722;4716.528347165325;5723.112917497794;5726.4273572642405;5730.398308177665;5731.942680573225;5738.311402631711;1412.0539238709885;1429.7855321701827;1436.425429828077;1437.6334034821264;1437.6693360527138;927.332320729074;956.7464621875208;976.5556671714353;986.837171866634;1013.8023085498404;4899.951000489949;5002.199648056294;5010.849674509771;5017.197248440232;5018.4981501849525;5899.174115623816;5922.940770592325;5934.258217722785;5980.521558275327;5999.340072592011;5045;5054.82308119214;5055.51972562606;5060.1903695408555;5061.44324124346;3149.7952633078776;3189.9362012759616;3191.8723251069696;3193.3613277344625;3193.632732235776;5571.9721401392735;5583.637063590853;5598.412166722517;5599.300087489064;5599.580031497654;5882.176495290662;6164.291106522717;6197.25632924052;6226.719797609118;6228.813135605939;5565.30433695788;5594.888102237933;5595.776168953278;5596.468335508121;5596.972015139898;5966.433188847052;5981.3719559445635;5987.191729116514;5989.071693887455;5993;5855.2973643163095;5869.4717475427415;5872.55955803325;5873;5875.941240587539;5355.036093503207;5551.417101204315;5566.165075238747;5576.386597474194;5601.159826026129;3923.9019024523473;3943.3296339622907;3961.1285517186175;3963.246983073207;3968.6229808168177;5877;5946.940530594638;5949.2266005419015;5950.404959504015;5953.315368732651;5737.426257374229;5741.827745167651;5758.913616295843;5764.07774756037;5772.04761214395;5753.453421924911;5755.942440575541;5763.250777398911;5764.279465066867;5766.654000759968;5437.972810135924;5637.408072152365;5662.745176467151;5663.7451314690115;5673.687947162945;5792.391798861059;5811.070228763378;5817.912731308949;5829.358770535153;5836.737346819488;5657.519110875622;5676;5681.9431805681415;5684.118961560799;5686.033374326457 14:48:38 INFO - PROCESS | 18037 | |5;yui.html;645.651348271933;663.118052989524;668.8261052126447;671.194566520176;750.8886847465751;11922.940385298083;11938.522459101636;12027.879721202786;12075.577354792584;12105.334206618632;11299.548018079287;11410.258333208336;11413.144014198926;11443.313401195914;11447.370394628291;633.4963703855447;774.0363247756551;774.4656187230821;791.0625908298684;794.6741835847304;802.4904185842004;802.5545822068749;806.238104990784;806.8063664720454;807.0114110214998;838.7357982235607;838.7651457591884;840.0675250472002;842.7303262955857;842.8609279468881;657.9901301480481;818.607068607069;831.1231650608605;833.3374966901328;834.9666013359458;607.2227548737623;612.2377639838385;612.8590424202414;615.6767696959088;619.6375120554482;11185.32888026721;11187.608433704863;11195.944020279929;11251.381174035425;11282.323060616389;11324.32054076758;11796.70508237301;11849.763004739856;12333.075019373582;12588.05589580785;9918.504074796232;9951.004899509991;10004.749881253027;10014.496375906023;10103.545340459697;3311.271520265562;3324.6675332466803;3333.283344081034;3339.799612023262;3360.83195840207;42368.57631423677;42517.14965700669;42598.36102458466;42762;42768.93077673052;9723.951380243196;9788.902110978941;10041.447720375303;10100.242481813746;10150.289479736348;17315.56711082233;17382.130893455276;17402.129893505273;17612.471625851245;17613.119344032748;6599.70301336441;6640.269570347258;6741.7303307868115;6855.485838562028;6947.617881016593;3521.2605352876185;3602.729795265313;3610.765300255475;3641.963580364162;3655.817209139532;2719.7280271972645;2738.7398197171237;2750.174947515737;2750.8487033213364;2758.3379988802944;499.84504803511027;525.4272842601582;527.5832092646842;543.0279799159539;555.6360583817606;609.2567068176817;614.3949653469258;614.7878981751288;647.1005302629349;647.6308504152588;7223.638818059076;7310.52481588695;7343.9632801836715;7556.168821429638;7652.923470765332;579.3077272659132;594.2007999241014;608.5344711295862;609.7500024989733;619.145579100838;3461.4115600348;3490.3891818932093;3498.58017037952;3499.0902365384673;3611.7652352596997;50921.490785092414;52728.20907686388;52786;53146;53149.7342513285;44253.77873110614;44425.33361999573;48176;48201.75899120482;48607.5139248603;42160.1567968645;42696.808962700234;42930.356044659355;43563;43881.78059109748;6856.897146542906;7001.789946301619;7055.259197784364;7087.078679771596;7095.184053833668;32371;32443;33169.66830331762;33278.66721332756;33333;39101.80449097736;39398.40902386409;39560.40659390054;42819;42969.570304296554;8424.410291279552;8430.789230269047;8489.4481858679;8584.227419532272;8695.047162778708;9393.859092113487;9433.811323773623;9533.380330278509;9616.855747163658;9619.759506012406;7902.762917112495;8167.387445941459;8168.264856162974;8286.337093032422;8381.832363352576;8890.86663700058;8893.575102345972;8906.554672266491;9016.864747028669;9367.953160234156;8300.916990830256;8377.413581049268;8410.411271210956;8671.696490622799;8758.03661597211;7353.191148973501;7526.698932042657;7546.434017448603;7583.696652133853;8029.799255018671;7274.272572742683;7473.080436703449;7503.512271702322;7528.209537998431;7570.086928750353 14:48:38 INFO - PROCESS | 18037 | __end_tp_report 14:48:38 INFO - PROCESS | 18037 | __start_cc_report 14:48:38 INFO - PROCESS | 18037 | _x_x_mozilla_cycle_collect,972 14:48:38 INFO - PROCESS | 18037 | __end_cc_report 14:48:38 INFO - PROCESS | 18037 | __startTimestamp1457822918556__endTimestamp 14:48:38 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | ------- Summary: start ------- 14:48:38 INFO - PROCESS | 18037 | Number of tests: 6 14:48:38 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | [#0] dojo.html Cycles:165 Average:4594.59 Median:4722.69 stddev:467.20 (9.9%) stddev-sans-first:440.49 14:48:38 INFO - PROCESS | 18037 | Values: 2559.1 2627.1 2635.0 2641.7 2662.1 4568.0 4582.3 4591.7 4596.9 4621.4 4628.5 4657.2 4683.3 4690.5 4699.2 4306.6 4311.3 4317.0 4329.8 4460.3 4240.3 4389.1 4397.0 4430.9 4445.9 4255.5 4309.4 4318.7 4329.6 4338.5 4230.0 4238.5 4267.8 4273.2 4325.8 4204.2 4212.2 4218.6 4235.8 4245.5 4459.6 4547.5 4597.0 4613.4 4633.0 4855.6 4891.6 4896.7 4901.4 4911.6 4916.8 4920.4 4925.3 4932.1 4941.7 4569.4 4641.6 4667.8 4711.2 4717.2 4975.5 4989.0 4992.1 4992.4 4995.3 4788.8 4793.1 4794.0 4803.4 4839.4 4932.5 4973.8 4977.5 5010.6 5016.5 4843.4 4891.7 4938.4 4950.4 4969.0 4796.0 4836.1 4907.6 4926.3 4985.5 4241.3 4250.6 4253.5 4267.5 4305.6 3681.1 3683.9 3685.9 3686.1 3731.4 4241.1 4250.7 4264.8 4269.5 4308.9 4931.3 4964.9 4966.0 5003.8 5018.1 4280.8 4283.4 4287.8 4331.6 4332.0 4451.3 4492.5 4532.8 4534.4 4534.5 4702.8 4703.4 4722.7 4734.7 4767.9 5004.6 5005.4 5009.4 5018.5 5045.0 4590.0 4638.2 4689.2 4718.3 4762.9 4870.5 4897.4 4899.5 4937.8 4947.0 4966.6 4968.0 4969.5 4969.8 5005.5 4709.6 4835.8 4842.6 4883.5 4908.4 4850.7 4864.3 4896.1 4902.1 4936.9 4794.9 4803.5 4811.1 4822.3 4868.5 4760.5 4872.9 4905.2 4920.2 4953.0 4796.4 4804.6 4814.3 4821.1 4872.4 14:48:38 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | [#1] ext.html Cycles:180 Average:43402.73 Median:19315.11 stddev:76412.82 (395.6%) stddev-sans-first:76559.42 14:48:38 INFO - PROCESS | 18037 | Values: 544.6 551.2 567.2 570.0 579.6 28117.9 35101.5 35447.6 35532.1 35542.5 39188.8 39575.8 39658.8 39687.0 39708.2 7768.2 7931.4 7973.9 7976.5 7980.3 7834.3 7952.2 7962.1 7963.8 8162.2 8122.0 8210.9 8210.9 8213.6 8216.6 8054.8 8111.6 8139.6 8143.6 8146.1 7928.1 8028.9 8047.6 8052.4 8053.8 38694.8 39149.6 39164.4 39209.2 39242.6 3272.0 3339.7 3340.1 3387.0 3883.0 28833.3 29376.3 29505.9 29711.0 30569.5 3431.9 3453.7 3475.3 3497.6 3528.8 257375.0 258485.0 258863.0 259006.0 259072.0 43526.1 44119.8 58131.4 58149.4 58525.1 42348.4 42456.0 42491.0 42560.0 42596.0 14320.6 14516.1 14519.9 14529.0 14530.3 11584.8 11589.4 11654.9 11659.0 11668.1 14279.5 14883.6 14956.1 14998.5 15064.5 5877.3 5961.5 6018.8 6042.8 6046.8 825.0 847.8 885.4 920.3 952.9 26938.3 28004.9 28036.4 28200.7 28208.3 958.2 986.4 987.6 993.1 1050.3 13840.2 14770.2 15445.4 16247.6 16411.0 378413.0 383484.0 383741.0 383919.0 384345.0 51980.2 52527.0 52531.7 52541.0 52740.7 1087.9 1205.9 1273.2 1289.2 1386.0 24980.9 25880.6 25957.2 25993.4 28137.2 39425.2 39663.2 39940.8 39958.0 40011.4 189755.1 190043.0 202490.0 203791.0 204252.0 28813.3 32849.3 33920.3 34003.4 34156.1 38186.2 38462.4 38734.8 39145.4 39262.6 32351.4 33440.8 33992.0 34068.3 34156.7 33222.8 33395.7 33569.5 33670.0 34210.0 33406.7 34196.7 34235.7 34515.1 34520.0 29449.1 30045.4 30385.0 30454.5 30633.4 22957.4 23034.5 23482.9 23633.0 23648.5 14:48:38 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | [#2] jquery.html Cycles:180 Average:23307.28 Median:5060.87 stddev:63651.80 (1257.7%) stddev-sans-first:63807.03 14:48:38 INFO - PROCESS | 18037 | Values: 355.1 359.4 363.2 368.3 369.7 15481.8 15617.7 16791.5 16807.2 16891.3 15733.7 16152.9 16373.9 16397.5 16416.6 4825.1 4866.0 4990.9 4993.3 4997.5 3678.3 5534.9 5806.7 5809.0 5810.2 5750.3 5755.0 5763.3 5775.7 5778.6 5613.6 5709.3 5749.4 5760.7 5819.9 5041.6 5056.7 5060.1 5061.6 5064.2 18166.4 19021.1 19124.8 19146.4 19162.0 2004.1 2019.8 2022.3 2193.5 2353.6 11398.4 11918.0 12470.4 12769.0 12836.3 1684.4 1755.8 1909.7 1998.3 2020.4 55027.2 55541.2 55838.0 57010.4 62064.7 9500.6 9841.1 9973.8 9982.4 10059.0 12737.8 12742.7 12815.3 12882.7 12892.0 7244.3 7423.5 7472.0 7530.1 7541.1 7156.0 7231.2 7316.5 7324.8 7394.3 4297.5 4402.2 4408.4 4409.7 4411.3 1699.7 1761.7 1762.6 1807.7 1812.2 825.9 857.9 931.1 949.9 992.5 14303.6 14628.3 14919.9 15372.6 15473.4 875.3 903.3 969.6 975.3 987.5 8921.8 8942.1 8968.3 9000.4 9185.4 375746.0 382118.0 390627.0 393616.0 394178.0 67439.7 72072.0 72074.0 72224.6 74113.5 928.2 935.3 951.9 953.3 956.6 13851.2 14109.9 14126.3 14205.0 14420.1 33464.3 34222.1 34488.8 34905.3 35369.0 46160.8 48854.0 48906.8 49513.8 49617.8 7260.8 7362.3 7370.2 7393.1 7473.9 6280.3 8734.4 9417.3 9746.6 10949.0 9193.7 9255.0 9637.8 9803.8 9822.5 9502.4 9532.0 9592.5 9697.6 9771.8 4916.1 6345.7 9060.5 9631.1 10335.5 6899.4 7393.1 7492.6 7529.2 7710.6 7946.9 9740.2 10050.4 10199.6 10286.8 14:48:38 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | [#3] mootools.html Cycles:180 Average:5189.50 Median:6027.26 stddev:2683.66 (44.5%) stddev-sans-first:2675.42 14:48:38 INFO - PROCESS | 18037 | Values: 1318.9 1414.4 1422.8 1582.6 1779.2 6807.3 6971.4 6980.1 6986.0 6988.1 7098.2 7255.5 7267.0 7273.5 7280.5 1830.9 1875.6 2158.4 2208.1 2235.6 2162.1 2165.5 2167.2 2167.5 2168.5 2109.8 2119.1 2126.6 2217.2 2227.3 2172.3 2184.5 2187.6 2191.0 2191.9 2196.1 2208.6 2211.9 2212.8 2214.3 7411.8 7466.6 7470.5 7475.3 7484.1 4489.5 4560.3 4572.2 4601.4 4604.8 2789.3 2930.2 2937.7 2958.5 2968.3 936.6 944.8 949.8 970.6 994.7 10111.7 10119.2 10125.8 10132.1 10133.6 4067.2 4149.3 4154.0 4168.4 4191.2 8687.8 8694.8 8702.3 8704.1 8713.6 4505.1 4511.7 4530.4 4531.8 4539.3 3652.7 3693.7 4013.6 4094.6 4125.4 3544.9 3551.4 3611.0 3622.4 3626.2 1158.1 1204.6 1215.5 1225.0 1225.5 1013.8 1026.1 1035.6 1116.1 1250.1 7072.9 7083.3 7091.3 7109.4 7123.6 1107.1 1131.5 1138.2 1163.6 1167.3 5465.2 5477.1 5503.9 5518.2 5530.4 8549.4 8650.0 8793.0 8805.7 8922.3 8999.7 9249.8 9256.3 9257.2 9283.3 6865.7 6895.3 7083.4 7098.1 7098.7 7020.2 7111.8 7130.3 7148.3 7183.5 8008.0 8119.3 8163.1 8199.5 8351.0 8251.3 8581.4 8685.7 8789.7 8794.0 5706.3 6138.5 6260.9 6586.1 6677.5 6835.5 6916.4 6927.9 6954.3 6958.1 6107.9 6320.9 6365.5 6489.2 6499.2 6087.7 6136.2 6227.6 6298.8 6404.2 6625.4 6666.4 6675.9 6700.8 6703.3 5849.8 6106.8 6155.1 6164.9 6166.5 5952.6 6006.8 6023.0 6027.1 6027.5 14:48:38 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | [#4] prototype.html Cycles:180 Average:4722.22 Median:5444.47 stddev:1417.88 (26.0%) stddev-sans-first:1382.69 14:48:38 INFO - PROCESS | 18037 | Values: 312.7 313.8 316.2 318.3 318.7 5332.4 5465.5 5484.2 5498.5 5527.8 5321.8 5437.5 5451.0 5451.4 5451.6 3903.5 4042.0 4163.8 4186.5 4192.9 4165.8 4175.5 4180.2 4183.6 4185.1 4117.8 4123.2 4128.3 4131.9 4138.5 3886.4 3995.9 4108.0 4124.2 4131.7 3550.0 3563.5 3571.0 3574.5 3577.6 5114.1 5145.8 5149.2 5150.5 5161.0 4743.4 4750.1 4755.6 4755.8 4758.7 5692.5 5698.6 5699.9 5710.2 5720.4 3901.2 3908.6 3919.9 3930.0 3930.3 5768.8 5930.7 6099.0 6101.7 6121.3 3958.9 3971.3 3981.7 3986.9 3992.3 4038.4 4041.9 4042.1 4044.6 4047.2 4703.5 4706.6 4709.9 4713.0 4716.5 5723.1 5726.4 5730.4 5731.9 5738.3 1412.1 1429.8 1436.4 1437.6 1437.7 927.3 956.7 976.6 986.8 1013.8 4900.0 5002.2 5010.8 5017.2 5018.5 5899.2 5922.9 5934.3 5980.5 5999.3 5045.0 5054.8 5055.5 5060.2 5061.4 3149.8 3189.9 3191.9 3193.4 3193.6 5572.0 5583.6 5598.4 5599.3 5599.6 5882.2 6164.3 6197.3 6226.7 6228.8 5565.3 5594.9 5595.8 5596.5 5597.0 5966.4 5981.4 5987.2 5989.1 5993.0 5855.3 5869.5 5872.6 5873.0 5875.9 5355.0 5551.4 5566.2 5576.4 5601.2 3923.9 3943.3 3961.1 3963.2 3968.6 5877.0 5946.9 5949.2 5950.4 5953.3 5737.4 5741.8 5758.9 5764.1 5772.0 5753.5 5755.9 5763.3 5764.3 5766.7 5438.0 5637.4 5662.7 5663.7 5673.7 5792.4 5811.1 5817.9 5829.4 5836.7 5657.5 5676.0 5681.9 5684.1 5686.0 14:48:38 INFO - PROCESS | 18037 | 14:48:38 INFO - PROCESS | 18037 | [#5] yui.html Cycles:180 Average:12281.03 Median:609.50 stddev:14648.33 (2403.3%) stddev-sans-first:14663.36 14:48:38 INFO - PROCESS | 18037 | Values: 645.7 663.1 668.8 671.2 750.9 11922.9 11938.5 12027.9 12075.6 12105.3 11299.5 11410.3 11413.1 11443.3 11447.4 633.5 774.0 774.5 791.1 794.7 802.5 802.6 806.2 806.8 807.0 838.7 838.8 840.1 842.7 842.9 658.0 818.6 831.1 833.3 835.0 607.2 612.2 612.9 615.7 619.6 11185.3 11187.6 11195.9 11251.4 11282.3 11324.3 11796.7 11849.8 12333.1 12588.1 9918.5 9951.0 10004.7 10014.5 10103.5 3311.3 3324.7 3333.3 3339.8 3360.8 42368.6 42517.1 42598.4 42762.0 42768.9 9724.0 9788.9 10041.4 10100.2 10150.3 17315.6 17382.1 17402.1 17612.5 17613.1 6599.7 6640.3 6741.7 6855.5 6947.6 3521.3 3602.7 3610.8 3642.0 3655.8 2719.7 2738.7 2750.2 2750.8 2758.3 499.8 525.4 527.6 543.0 555.6 609.3 614.4 614.8 647.1 647.6 7223.6 7310.5 7344.0 7556.2 7652.9 579.3 594.2 608.5 609.8 619.1 3461.4 3490.4 3498.6 3499.1 3611.8 50921.5 52728.2 52786.0 53146.0 53149.7 44253.8 44425.3 48176.0 48201.8 48607.5 42160.2 42696.8 42930.4 43563.0 43881.8 6856.9 7001.8 7055.3 7087.1 7095.2 32371.0 32443.0 33169.7 33278.7 33333.0 39101.8 39398.4 39560.4 42819.0 42969.6 8424.4 8430.8 8489.4 8584.2 8695.0 9393.9 9433.8 9533.4 9616.9 9619.8 7902.8 8167.4 8168.3 8286.3 8381.8 8890.9 8893.6 8906.6 9016.9 9368.0 8300.9 8377.4 8410.4 8671.7 8758.0 7353.2 7526.7 7546.4 7583.7 8029.8 7274.3 7473.1 7503.5 7528.2 7570.1 14:48:38 INFO - PROCESS | 18037 | -------- Summary: end -------- 14:48:38 INFO - PROCESS | 18037 | 14:48:39 INFO - TEST-INFO | 18037: exit 0 14:48:39 INFO - TEST-OK | dromaeo_css | took 1116361ms 14:48:39 INFO - TEST-START | kraken 14:48:39 INFO - operating with platform_type : linux_ 14:48:39 INFO - Initialising browser for kraken test... 14:48:39 INFO - TEST-INFO | started process 18218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlkCL0/profile http://localhost:36110/getInfo.html) 14:48:43 INFO - PROCESS | 18218 | __metrics Screen width/height:1600/1200 14:48:43 INFO - PROCESS | 18218 | colorDepth:24 14:48:43 INFO - PROCESS | 18218 | Browser inner width/height: 1024/697 14:48:43 INFO - PROCESS | 18218 | __metrics 14:48:44 ERROR - PROCESS | 18218 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:48:44 INFO - PROCESS | 18218 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:48:45 INFO - TEST-INFO | 18218: exit 0 14:48:45 INFO - Browser initialized. 14:48:45 INFO - Running cycle 1/1 for kraken test... 14:48:45 INFO - TEST-INFO | started process 18297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlkCL0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:57 INFO - PROCESS | 18297 | RSS: Main: 154439680 14:48:57 INFO - PROCESS | 18297 | 14:48:59 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36110/tests/kraken/driver.html?testName=audio-beat-detection) 14:49:00 INFO - PROCESS | 18297 | RSS: Main: 196333568 14:49:00 INFO - PROCESS | 18297 | 14:49:02 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36110/tests/kraken/driver.html?testName=audio-dft) 14:49:03 INFO - PROCESS | 18297 | RSS: Main: 186028032 14:49:03 INFO - PROCESS | 18297 | 14:49:06 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36110/tests/kraken/driver.html?testName=audio-fft) 14:49:07 INFO - PROCESS | 18297 | RSS: Main: 172900352 14:49:07 INFO - PROCESS | 18297 | 14:49:09 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36110/tests/kraken/driver.html?testName=audio-oscillator) 14:49:09 INFO - PROCESS | 18297 | RSS: Main: 173666304 14:49:09 INFO - PROCESS | 18297 | 14:49:12 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:49:12 INFO - PROCESS | 18297 | RSS: Main: 175816704 14:49:12 INFO - PROCESS | 18297 | 14:49:15 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36110/tests/kraken/driver.html?testName=imaging-darkroom) 14:49:16 INFO - PROCESS | 18297 | RSS: Main: 175738880 14:49:16 INFO - PROCESS | 18297 | 14:49:19 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36110/tests/kraken/driver.html?testName=imaging-desaturate) 14:49:20 INFO - PROCESS | 18297 | RSS: Main: 175243264 14:49:20 INFO - PROCESS | 18297 | 14:49:23 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36110/tests/kraken/driver.html?testName=json-parse-financial) 14:49:23 INFO - PROCESS | 18297 | RSS: Main: 175648768 14:49:23 INFO - PROCESS | 18297 | 14:49:25 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:49:26 INFO - PROCESS | 18297 | RSS: Main: 186105856 14:49:26 INFO - PROCESS | 18297 | 14:49:28 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36110/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:49:28 INFO - PROCESS | 18297 | RSS: Main: 181923840 14:49:28 INFO - PROCESS | 18297 | 14:49:30 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:49:31 INFO - PROCESS | 18297 | RSS: Main: 188039168 14:49:31 INFO - PROCESS | 18297 | 14:49:33 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:49:34 INFO - PROCESS | 18297 | RSS: Main: 196775936 14:49:34 INFO - PROCESS | 18297 | 14:49:36 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:49:37 INFO - PROCESS | 18297 | RSS: Main: 196472832 14:49:37 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | Cycle 1(1): loaded http://localhost:36110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36110/tests/kraken/driver.html?testName=ai-astar) 14:49:39 INFO - PROCESS | 18297 | RSS: Main: 255348736 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | __start_tp_report 14:49:39 INFO - PROCESS | 18297 | _x_x_mozilla_page_load 14:49:39 INFO - PROCESS | 18297 | _x_x_mozilla_page_load_details 14:49:39 INFO - PROCESS | 18297 | |i|pagename|runs| 14:49:39 INFO - PROCESS | 18297 | |0;ai-astar;111;113;108;111;113;114;102;112;113;112 14:49:39 INFO - PROCESS | 18297 | |1;audio-beat-detection;159;133;147;168;131;154;151;130;176;131 14:49:39 INFO - PROCESS | 18297 | |2;audio-dft;162;162;162;162;162;163;163;163;164;162 14:49:39 INFO - PROCESS | 18297 | |3;audio-fft;73;73;124;97;74;74;73;111;94;74 14:49:39 INFO - PROCESS | 18297 | |4;audio-oscillator;94;93;137;92;96;94;141;94;96;134 14:49:39 INFO - PROCESS | 18297 | |5;imaging-gaussian-blur;117;117;117;118;117;117;116;117;117;117 14:49:39 INFO - PROCESS | 18297 | |6;imaging-darkroom;146;146;147;145;148;146;146;146;146;146 14:49:39 INFO - PROCESS | 18297 | |7;imaging-desaturate;95;96;96;95;96;95;95;96;95;95 14:49:39 INFO - PROCESS | 18297 | |8;json-parse-financial;66;67;66;66;68;67;67;80;67;65 14:49:39 INFO - PROCESS | 18297 | |9;json-stringify-tinderbox;65;65;65;65;66;65;64;65;65;65 14:49:39 INFO - PROCESS | 18297 | |10;stanford-crypto-aes;88;81;82;89;80;82;81;87;81;82 14:49:39 INFO - PROCESS | 18297 | |11;stanford-crypto-ccm;118;121;116;117;129;118;126;129;117;124 14:49:39 INFO - PROCESS | 18297 | |12;stanford-crypto-pbkdf2;140;129;138;138;139;128;143;140;137;137 14:49:39 INFO - PROCESS | 18297 | |13;stanford-crypto-sha256-iterative;73;65;67;67;65;66;66;65;65;65 14:49:39 INFO - PROCESS | 18297 | __end_tp_report 14:49:39 INFO - PROCESS | 18297 | __start_cc_report 14:49:39 INFO - PROCESS | 18297 | _x_x_mozilla_cycle_collect,1139 14:49:39 INFO - PROCESS | 18297 | __end_cc_report 14:49:39 INFO - PROCESS | 18297 | __startTimestamp1457822979537__endTimestamp 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | ------- Summary: start ------- 14:49:39 INFO - PROCESS | 18297 | Number of tests: 14 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.54 (3.1%) stddev-sans-first:3.76 14:49:39 INFO - PROCESS | 18297 | Values: 111.0 113.0 108.0 111.0 113.0 114.0 102.0 112.0 113.0 112.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:152.50 stddev:16.59 (10.9%) stddev-sans-first:17.12 14:49:39 INFO - PROCESS | 18297 | Values: 159.0 133.0 147.0 168.0 131.0 154.0 151.0 130.0 176.0 131.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 14:49:39 INFO - PROCESS | 18297 | Values: 162.0 162.0 162.0 162.0 162.0 163.0 163.0 163.0 164.0 162.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#3] audio-fft Cycles:10 Average:86.70 Median:74.00 stddev:18.82 (25.4%) stddev-sans-first:19.30 14:49:39 INFO - PROCESS | 18297 | Values: 73.0 73.0 124.0 97.0 74.0 74.0 73.0 111.0 94.0 74.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:94.00 stddev:20.96 (22.3%) stddev-sans-first:21.69 14:49:39 INFO - PROCESS | 18297 | Values: 94.0 93.0 137.0 92.0 96.0 94.0 141.0 94.0 96.0 134.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 14:49:39 INFO - PROCESS | 18297 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 14:49:39 INFO - PROCESS | 18297 | Values: 146.0 146.0 147.0 145.0 148.0 146.0 146.0 146.0 146.0 146.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:49:39 INFO - PROCESS | 18297 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#8] json-parse-financial Cycles:10 Average:67.90 Median:67.00 stddev:4.33 (6.5%) stddev-sans-first:4.54 14:49:39 INFO - PROCESS | 18297 | Values: 66.0 67.0 66.0 66.0 68.0 67.0 67.0 80.0 67.0 65.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 14:49:39 INFO - PROCESS | 18297 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 64.0 65.0 65.0 65.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:3.33 (4.1%) stddev-sans-first:3.07 14:49:39 INFO - PROCESS | 18297 | Values: 88.0 81.0 82.0 89.0 80.0 82.0 81.0 87.0 81.0 82.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.50 stddev:5.10 (4.2%) stddev-sans-first:5.25 14:49:39 INFO - PROCESS | 18297 | Values: 118.0 121.0 116.0 117.0 129.0 118.0 126.0 129.0 117.0 124.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.90 Median:138.50 stddev:4.77 (3.4%) stddev-sans-first:4.93 14:49:39 INFO - PROCESS | 18297 | Values: 140.0 129.0 138.0 138.0 139.0 128.0 143.0 140.0 137.0 137.0 14:49:39 INFO - PROCESS | 18297 | 14:49:39 INFO - PROCESS | 18297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.00 stddev:2.46 (3.7%) stddev-sans-first:0.87 14:49:39 INFO - PROCESS | 18297 | Values: 73.0 65.0 67.0 67.0 65.0 66.0 66.0 65.0 65.0 65.0 14:49:39 INFO - PROCESS | 18297 | -------- Summary: end -------- 14:49:39 INFO - PROCESS | 18297 | 14:49:40 INFO - TEST-INFO | 18297: exit 0 14:49:40 INFO - TEST-OK | kraken | took 61259ms 14:49:40 INFO - SUITE-END | took 1177s 14:49:40 INFO - Completed test suite (00:19:37) 14:49:40 INFO - javascript benchmark 14:49:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2559.0502082657817, 2627.106783693544, 2635.0250407349286, 2641.7490338417842, 2662.108193755092, 4568.0, 4582.335561343603, 4591.678582499227, 4596.885077873055, 4621.445426548818, 4628.4677262114865, 4657.2082745933185, 4683.274092515657, 4690.5074967128385, 4699.248120300753, 4306.61240488356, 4311.267084595618, 4317.0, 4329.826806927719, 4460.286354183331, 4240.342746874224, 4389.056352884129, 4397.032652816391, 4430.867073987785, 4445.866624001269, 4255.5318914919335, 4309.439772829513, 4318.740875547462, 4329.567043295677, 4338.501072376685, 4229.957700423018, 4238.470191226097, 4267.786610669454, 4273.166732487166, 4325.82696692132, 4204.2432362174795, 4212.220739163234, 4218.641415479688, 4235.809388577491, 4245.511766146902, 4459.598636122764, 4547.45430548333, 4597.034622729231, 4613.446386433616, 4633.027064316498, 4855.562999330077, 4891.559759621616, 4896.730679812609, 4901.387326584177, 4911.557959783601, 4916.754162291871, 4920.434150072751, 4925.26121081837, 4932.112219800434, 4941.703497790144, 4569.360289559464, 4641.6286697063815, 4667.813287468463, 4711.246200607886, 4717.198076327033, 4975.477574854661, 4989.027139707722, 4992.104579343972, 4992.350994370709, 4995.250712393097, 4788.784504697297, 4793.113274044313, 4794.041191761662, 4803.447603525639, 4839.395075615548, 4932.53140951609, 4973.776180071905, 4977.502249774993, 5010.574101201366, 5016.498350165028, 4843.418789745253, 4891.657583969088, 4938.4320803107385, 4950.356453661001, 4968.950310496921, 4795.976020119877, 4836.105320515716, 4907.55831975124, 4926.285688575136, 4985.501449854985, 4241.321388577812, 4250.596193361687, 4253.532111467736, 4267.487901451846, 4305.612494875476, 3681.079730067483, 3683.9447408288897, 3685.8894233173046, 3686.1337585667347, 3731.402975523903, 4241.088166044316, 4250.723702959298, 4264.7654379009455, 4269.530351661315, 4308.913821723548, 4931.284963680247, 4964.90070198594, 4965.9751701241985, 5003.799848006039, 5018.121828679967, 4280.764557949343, 4283.421738065384, 4287.849925252601, 4331.610155085994, 4332.0, 4451.3323001550025, 4492.505824359318, 4532.818687252539, 4534.387857639176, 4534.523874993144, 4702.835400760957, 4703.3885594872445, 4722.693024953367, 4734.715917044989, 4767.880802979953, 5004.624653150955, 5005.374328208974, 5009.448960614257, 5018.4981501849525, 5045.041442125985, 4590.0, 4638.165130276448, 4689.155951928549, 4718.292256161603, 4762.904741905073, 4870.488598697228, 4897.41231052276, 4899.510048995072, 4937.8271760488215, 4947.0, 4966.577840883565, 4968.0, 4969.527894849984, 4969.818612105617, 5005.549500544968, 4709.599684026759, 4835.8065677372515, 4842.612590992782, 4883.536064073907, 4908.386451693538, 4850.660453768202, 4864.294677271847, 4896.069746748107, 4902.068606964665, 4936.8765780855765, 4794.856154315376, 4803.495632958489, 4811.109944660249, 4822.300766388924, 4868.464468908488, 4760.523947605212, 4872.902541949212, 4905.166121759238, 4920.188168952082, 4952.950470495249, 4796.400449943757, 4804.591609713214, 4814.277858321279, 4821.108095002436, 4872.439669437918], "unit": "score", "name": "dojo.html", "value": 4565.505888424156}, {"lowerIsBetter": false, "replicates": [544.5561867078328, 551.1925029831298, 567.1634339349457, 569.9686517241553, 579.6000759475961, 28117.859410702942, 35101.47347789782, 35447.64552354476, 35532.11169720755, 35542.46686299701, 39188.80405597968, 39575.80212098943, 39658.8017059915, 39687.0, 39708.20583588334, 7768.223177682229, 7931.365490760725, 7973.920260797405, 7976.481528700616, 7980.324131932272, 7834.334081603042, 7952.165022672622, 7962.124166341698, 7963.800904977393, 8162.183781621849, 8121.959390203041, 8210.876836847452, 8210.917890821105, 8213.630386632585, 8216.630251638691, 8054.758357249292, 8111.634976426075, 8139.593020348959, 8143.552104634243, 8146.144654811219, 7928.127905930343, 8028.919710802876, 8047.637856296422, 8052.396070294692, 8053.798655033671, 38694.80652596747, 39149.60850391488, 39164.412533812014, 39209.21581568353, 39242.60757392418, 3271.96728032719, 3339.682730140657, 3340.1482621931495, 3387.0, 3883.0, 28833.27916802076, 29376.26559336034, 29505.852470737507, 29711.0, 30569.541456878163, 3431.9142021449666, 3453.689167974869, 3475.2528206435736, 3497.615262321143, 3528.752987290891, 257375.0, 258485.0, 258863.0, 259005.9999999981, 259071.9999999981, 43526.12947741027, 44119.77940110279, 58131.41868581345, 58149.4185058144, 58525.122123168185, 42348.3647745284, 42456.0, 42491.0, 42560.0, 42596.0, 14320.57038288853, 14516.056456330305, 14519.92740036293, 14529.0, 14530.273486325641, 11584.76830463386, 11589.420528973518, 11654.941725291319, 11659.0, 11668.066554675775, 14279.500217492337, 14883.627909302137, 14956.102633842005, 14998.500149985133, 15064.472743453927, 5877.265341832271, 5961.493273071751, 6018.759249629966, 6042.758289668452, 6046.818595442144, 825.0347093900151, 847.8080028691979, 885.3625389719392, 920.3373571028849, 952.8570714392896, 26938.32654183661, 28004.875583434892, 28036.43927121446, 28200.71799282022, 28208.29479262994, 958.1568219966385, 986.3687240166299, 987.5950860147306, 993.101243374747, 1050.2753100360726, 13840.23878686682, 14770.187639679922, 15445.382184712485, 16247.593810154603, 16411.0, 378413.0, 383484.0, 383741.0, 383919.0, 384345.0, 51980.220296694824, 52527.0, 52531.73734131305, 52541.0, 52740.73629631904, 1087.853139826129, 1205.921615095016, 1273.242420759628, 1289.239348784203, 1386.0090035624578, 24980.87509562513, 25880.61179082353, 25957.154518485862, 25993.350166245997, 28137.155885323475, 39425.21149576935, 39663.2067358657, 39940.800295998335, 39958.0, 40011.399829002, 189755.051224743, 190043.0, 202490.0, 203791.0, 204252.0, 28813.27966800847, 32849.34301314008, 33920.321593567496, 34003.42963988746, 34156.14609634779, 38186.236275274896, 38462.42306365351, 38734.80632596819, 39145.41281880831, 39262.60737392589, 32351.35297294088, 33440.832795835864, 33992.0, 34068.318633626695, 34156.658433415345, 33222.83388583042, 33395.66604333925, 33569.49645755267, 33670.0, 34210.0, 33406.66593334036, 34196.65803341935, 34235.657643424245, 34515.13712157216, 34520.0, 29449.11652650424, 30045.399092018473, 30385.0, 30454.54318185185, 30633.387332252783, 22957.426064348525, 23034.53930921406, 23482.88258558696, 23633.0, 23648.52702945966], "unit": "score", "name": "ext.html", "value": 17020.79124160171}, {"lowerIsBetter": false, "replicates": [355.08034191444153, 359.40339037198254, 363.15566308333126, 368.3241252302026, 369.7208607501336, 15481.767773483392, 15617.687646247068, 16791.496255112364, 16807.243674034667, 16891.324347026133, 15733.685326293467, 16152.919235403835, 16373.918130409362, 16397.524222819942, 16416.589585260375, 4825.10735513931, 4865.951340486586, 4990.87522811929, 4993.300937868701, 4997.5252351026775, 3678.3011227866755, 5534.861628459281, 5806.738696758656, 5809.01246788045, 5810.244668193129, 5750.252467179261, 5754.99287624664, 5763.337216220126, 5775.682337471459, 5778.59549831512, 5613.550915926737, 5709.31488221414, 5749.367569567345, 5760.654360738327, 5819.912701309484, 5041.621878359138, 5056.6713163644245, 5060.089183946888, 5061.645684802065, 5064.164412871872, 18166.364177253734, 19021.14404851771, 19124.80875191258, 19146.425607231806, 19162.0, 2004.0681083296338, 2019.848511361639, 2022.2921977307972, 2193.484531135182, 2353.6116540770754, 11398.430078496041, 11918.0, 12470.376481175996, 12769.0, 12836.294003829786, 1684.4188754879547, 1755.806861245262, 1909.6849019911697, 1998.270631219609, 2020.3938818354434, 55027.17459238115, 55541.1668824972, 55838.0, 57010.42989570092, 62064.68967655178, 9500.572474238537, 9841.065098815601, 9973.80052398948, 9982.401055936667, 10059.044390782863, 12737.808932866015, 12742.745145097046, 12815.295158766357, 12882.742345153045, 12892.033097517537, 7244.311790379906, 7423.48035637511, 7472.028636277358, 7530.096388433423, 7541.095068591804, 7156.0, 7231.168415632164, 7316.487845850739, 7324.780256592311, 7394.260573942563, 4297.484301883794, 4402.229609818269, 4408.448943882015, 4409.669274804402, 4411.316245981878, 1699.6855581717423, 1761.6564769870008, 1762.5505496098413, 1807.6746185686702, 1812.2479171144091, 825.9091499935003, 857.8756080368312, 931.0689310689311, 949.8907625623003, 992.528548939248, 14303.64240893986, 14628.341724622418, 14919.850801491846, 15372.615684607974, 15473.381064757508, 875.3303722652176, 903.2503022491317, 969.5927710361665, 975.2636759246865, 987.4914419074182, 8921.821563568692, 8942.061083586259, 8968.282537396992, 9000.424925637988, 9185.402948808307, 375746.0, 382118.0, 390627.0, 393616.0, 394178.0, 67439.66280168567, 72072.0, 72074.0, 72224.63887680529, 74113.5177296451, 928.2481190235931, 935.2658163341744, 951.9333646644807, 953.2659851913987, 956.6269155029405, 13851.16892986424, 14109.929450352682, 14126.293685315899, 14205.0, 14420.134791912518, 33464.33071338608, 34222.14444638904, 34488.82755586206, 34905.30189396249, 35369.0, 46160.769196155146, 48854.0, 48906.75546622244, 49513.75243123761, 49617.751911240215, 7260.782176534713, 7362.263773622595, 7370.189279179179, 7393.112826460859, 7473.925260747323, 6280.309165991646, 8734.388592798443, 9417.340786144903, 9746.635471034202, 10949.0, 9193.678221262224, 9255.0, 9637.807243854942, 9803.754906127404, 9822.5088745561, 9502.429854208769, 9531.952340238255, 9592.472414017016, 9697.563609637442, 9771.80456390854, 4916.139675556692, 6345.682715864281, 9060.459721847434, 9631.08504692053, 10335.483225838829, 6899.413549848319, 7393.112826460859, 7492.587907664913, 7529.209433009455, 7710.575918324322, 7946.8807967879375, 9740.172085372822, 10050.396976181453, 10199.59201631956, 10286.794264114826], "unit": "score", "name": "jquery.html", "value": 7982.548842796877}, {"lowerIsBetter": false, "replicates": [1318.8747069028439, 1414.363536408616, 1422.805800976807, 1582.5885269829848, 1779.1993602878708, 6807.285235050316, 6971.372576468123, 6980.092587963558, 6986.0, 6988.056612357336, 7098.183708873481, 7255.455840811934, 7267.018952441419, 7273.490855640107, 7280.526765760222, 1830.9267629294811, 1875.634251320993, 2158.4064382294837, 2208.138825857917, 2235.619944609412, 2162.0703097667997, 2165.545235500539, 2167.241465487075, 2167.4581354661336, 2168.5120847809194, 2109.831213502916, 2119.1417475922276, 2126.5959467701164, 2217.2239716099316, 2227.27613525604, 2172.3374370816896, 2184.4648061224943, 2187.639039558471, 2191.0, 2191.901364438604, 2196.0556960506974, 2208.6134926387977, 2211.8562293450873, 2212.7676593957563, 2214.30249471416, 7411.777646670608, 7466.552006879605, 7470.47706660534, 7475.252474752536, 7484.064491938508, 4489.46126464823, 4560.338750881137, 4572.245579479382, 4601.3558101865765, 4604.7927843247135, 2789.3445040415486, 2930.1832863624477, 2937.6915423880614, 2958.5266357382716, 2968.3469636679897, 936.6440752514069, 944.8157609266195, 949.7530642033121, 970.6166064404591, 994.6866736977829, 10111.696649100539, 10119.190464762802, 10125.797484050352, 10132.138768204637, 10133.645322413753, 4067.206894655573, 4149.33610622299, 4153.958460415357, 4168.374743788456, 4191.1827193697545, 8687.782805429915, 8694.782630434163, 8702.347323950602, 8704.086070962585, 8713.564321783886, 4505.053938672915, 4511.70673906195, 4530.365748795171, 4531.77341132942, 4539.251023581138, 3652.7077833773233, 3693.7045036397026, 4013.57857424972, 4094.61101195386, 4125.401816736557, 3544.929101417957, 3551.4317709166926, 3611.0, 3622.4385220290897, 3626.220362622049, 1158.1198289300191, 1204.6325870609548, 1215.4955693387321, 1224.9938750306192, 1225.4914210602678, 1013.7516308504316, 1026.1277913773233, 1035.5857656937285, 1116.1349953785882, 1250.1374051904156, 7072.858542829217, 7083.291670832876, 7091.290870912971, 7109.395701365442, 7123.572585644878, 1107.0755918807886, 1131.4719007937952, 1138.1861968692424, 1163.6160067177811, 1167.2821214952912, 5465.180222966586, 5477.068898287301, 5503.862403439866, 5518.172274158908, 5530.364008139116, 8549.444286121383, 8649.956750216208, 8793.03276639569, 8805.69180078694, 8922.286217102615, 8999.730008099768, 9249.815003700023, 9256.259499240045, 9257.166854983085, 9283.257339412965, 6865.656717164122, 6895.34494223048, 7083.433325333961, 7098.077249957576, 7098.716051357887, 7020.227774944854, 7111.82220444493, 7130.322619351154, 7148.28517148281, 7183.497155199086, 8007.959960200162, 8119.30985866208, 8163.142869998802, 8199.508029518249, 8350.958245208734, 8251.2986396157, 8581.442206256574, 8685.739427817176, 8789.736307910773, 8794.0, 5706.28671416073, 6138.478229350555, 6260.906086408799, 6586.077949087035, 6677.499187560855, 6835.453163746789, 6916.412104970933, 6927.89608155868, 6954.3393377629045, 6958.095447591781, 6107.857722141247, 6320.873582528416, 6365.458935990493, 6489.1888513935755, 6499.1876015498065, 6087.66517841523, 6136.23297087864, 6227.626342419469, 6298.779542715983, 6404.199475065617, 6625.436837868835, 6666.366695163952, 6675.933240667726, 6700.83247918806, 6703.3296670332575, 5849.766009359748, 6106.755729770759, 6155.1382806406245, 6164.938350616437, 6166.475849552839, 5952.553558483044, 6006.819795406145, 6023.036314189709, 6027.065804800263, 6027.457528822251], "unit": "score", "name": "mootools.html", "value": 4280.605275324839}, {"lowerIsBetter": false, "replicates": [312.6529552197061, 313.7631088528161, 316.18266780372727, 318.3330921719001, 318.6781350835657, 5332.413434522199, 5465.50810427062, 5484.204790305408, 5498.4501549845, 5527.751251193696, 5321.840344789653, 5437.510624043835, 5450.972745136279, 5451.37309209441, 5451.563874889999, 3903.5315762108585, 4041.959580404188, 4163.75017498951, 4186.518550366716, 4192.895177620569, 4165.83336666533, 4175.498940127174, 4180.163967206571, 4183.62347388735, 4185.100203456256, 4117.794110294488, 4123.154753275571, 4128.256913755523, 4131.8553850615235, 4138.544760076389, 3886.436466712325, 3995.880123596268, 4108.0, 4124.154548317618, 4131.710780245384, 3550.04148879801, 3563.518924945125, 3570.9821450892578, 3574.4995700601935, 3577.6422357764013, 5114.053900028507, 5145.819896303648, 5149.201873709581, 5150.510701483353, 5160.974195129038, 4743.430788305391, 4750.12122757291, 4755.619550435957, 4755.785989630475, 4758.666893317469, 5692.487676109128, 5698.601097923147, 5699.886002279931, 5710.229119068914, 5720.399358067385, 3901.2197560487734, 3908.609139086097, 3919.863239660495, 3930.0, 3930.2925473414775, 5768.826935191909, 5930.733117009701, 6098.9695051524905, 6101.725422356005, 6121.326654068093, 3958.9010274742786, 3971.3050216212046, 3981.6814654827544, 3986.920261594752, 3992.301347264217, 4038.353863381845, 4041.8787436376956, 4042.0905296308097, 4044.6359827615656, 4047.170330082326, 4703.482616912137, 4706.576408123216, 4709.882252943704, 4713.010267843722, 4716.528347165325, 5723.112917497794, 5726.4273572642405, 5730.398308177665, 5731.942680573225, 5738.311402631711, 1412.0539238709885, 1429.7855321701827, 1436.425429828077, 1437.6334034821264, 1437.6693360527138, 927.332320729074, 956.7464621875208, 976.5556671714353, 986.837171866634, 1013.8023085498404, 4899.951000489949, 5002.199648056294, 5010.849674509771, 5017.197248440232, 5018.4981501849525, 5899.174115623816, 5922.940770592325, 5934.258217722785, 5980.521558275327, 5999.340072592011, 5045.0, 5054.82308119214, 5055.51972562606, 5060.1903695408555, 5061.44324124346, 3149.7952633078776, 3189.9362012759616, 3191.8723251069696, 3193.3613277344625, 3193.632732235776, 5571.9721401392735, 5583.637063590853, 5598.412166722517, 5599.300087489064, 5599.580031497654, 5882.176495290662, 6164.291106522717, 6197.25632924052, 6226.719797609118, 6228.813135605939, 5565.30433695788, 5594.888102237933, 5595.776168953278, 5596.468335508121, 5596.972015139898, 5966.433188847052, 5981.3719559445635, 5987.191729116514, 5989.071693887455, 5993.0, 5855.2973643163095, 5869.4717475427415, 5872.55955803325, 5873.0, 5875.941240587539, 5355.036093503207, 5551.417101204315, 5566.165075238747, 5576.386597474194, 5601.159826026129, 3923.9019024523473, 3943.3296339622907, 3961.1285517186175, 3963.246983073207, 3968.6229808168177, 5877.0, 5946.940530594638, 5949.2266005419015, 5950.404959504015, 5953.315368732651, 5737.426257374229, 5741.827745167651, 5758.913616295843, 5764.07774756037, 5772.04761214395, 5753.453421924911, 5755.942440575541, 5763.250777398911, 5764.279465066867, 5766.654000759968, 5437.972810135924, 5637.408072152365, 5662.745176467151, 5663.7451314690115, 5673.687947162945, 5792.391798861059, 5811.070228763378, 5817.912731308949, 5829.358770535153, 5836.737346819488, 5657.519110875622, 5676.0, 5681.9431805681415, 5684.118961560799, 5686.033374326457], "unit": "score", "name": "prototype.html", "value": 4267.892709095096}, {"lowerIsBetter": false, "replicates": [645.651348271933, 663.118052989524, 668.8261052126447, 671.194566520176, 750.8886847465751, 11922.940385298083, 11938.522459101636, 12027.879721202786, 12075.577354792584, 12105.334206618632, 11299.548018079287, 11410.258333208336, 11413.144014198926, 11443.313401195914, 11447.370394628291, 633.4963703855447, 774.0363247756551, 774.4656187230821, 791.0625908298684, 794.6741835847304, 802.4904185842004, 802.5545822068749, 806.238104990784, 806.8063664720454, 807.0114110214998, 838.7357982235607, 838.7651457591884, 840.0675250472002, 842.7303262955857, 842.8609279468881, 657.9901301480481, 818.607068607069, 831.1231650608605, 833.3374966901328, 834.9666013359458, 607.2227548737623, 612.2377639838385, 612.8590424202414, 615.6767696959088, 619.6375120554482, 11185.32888026721, 11187.608433704863, 11195.944020279929, 11251.381174035425, 11282.323060616389, 11324.32054076758, 11796.70508237301, 11849.763004739856, 12333.075019373582, 12588.05589580785, 9918.504074796232, 9951.004899509991, 10004.749881253027, 10014.496375906023, 10103.545340459697, 3311.271520265562, 3324.6675332466803, 3333.283344081034, 3339.799612023262, 3360.83195840207, 42368.57631423677, 42517.14965700669, 42598.36102458466, 42762.0, 42768.93077673052, 9723.951380243196, 9788.902110978941, 10041.447720375303, 10100.242481813746, 10150.289479736348, 17315.56711082233, 17382.130893455276, 17402.129893505273, 17612.471625851245, 17613.119344032748, 6599.70301336441, 6640.269570347258, 6741.7303307868115, 6855.485838562028, 6947.617881016593, 3521.2605352876185, 3602.729795265313, 3610.765300255475, 3641.963580364162, 3655.817209139532, 2719.7280271972645, 2738.7398197171237, 2750.174947515737, 2750.8487033213364, 2758.3379988802944, 499.84504803511027, 525.4272842601582, 527.5832092646842, 543.0279799159539, 555.6360583817606, 609.2567068176817, 614.3949653469258, 614.7878981751288, 647.1005302629349, 647.6308504152588, 7223.638818059076, 7310.52481588695, 7343.9632801836715, 7556.168821429638, 7652.923470765332, 579.3077272659132, 594.2007999241014, 608.5344711295862, 609.7500024989733, 619.145579100838, 3461.4115600348, 3490.3891818932093, 3498.58017037952, 3499.0902365384673, 3611.7652352596997, 50921.490785092414, 52728.20907686388, 52786.0, 53146.0, 53149.7342513285, 44253.77873110614, 44425.33361999573, 48176.0, 48201.75899120482, 48607.5139248603, 42160.1567968645, 42696.808962700234, 42930.356044659355, 43563.0, 43881.78059109748, 6856.897146542906, 7001.789946301619, 7055.259197784364, 7087.078679771596, 7095.184053833668, 32371.0, 32443.0, 33169.66830331762, 33278.66721332756, 33333.0, 39101.80449097736, 39398.40902386409, 39560.40659390054, 42819.0, 42969.570304296554, 8424.410291279552, 8430.789230269047, 8489.4481858679, 8584.227419532272, 8695.047162778708, 9393.859092113487, 9433.811323773623, 9533.380330278509, 9616.855747163658, 9619.759506012406, 7902.762917112495, 8167.387445941459, 8168.264856162974, 8286.337093032422, 8381.832363352576, 8890.86663700058, 8893.575102345972, 8906.554672266491, 9016.864747028669, 9367.953160234156, 8300.916990830256, 8377.413581049268, 8410.411271210956, 8671.696490622799, 8758.03661597211, 7353.191148973501, 7526.698932042657, 7546.434017448603, 7583.696652133853, 8029.799255018671, 7274.272572742683, 7473.080436703449, 7503.512271702322, 7528.209537998431, 7570.086928750353], "unit": "score", "name": "yui.html", "value": 5584.810495695718}], "name": "dromaeo_css", "value": 6312.91729460391}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 108.0, 111.0, 113.0, 114.0, 102.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [159.0, 133.0, 147.0, 168.0, 131.0, 154.0, 151.0, 130.0, 176.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 163.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 124.0, 97.0, 74.0, 74.0, 73.0, 111.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.7}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 137.0, 92.0, 96.0, 94.0, 141.0, 94.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 145.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 67.0, 67.0, 80.0, 67.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 82.0, 89.0, 80.0, 82.0, 81.0, 87.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 116.0, 117.0, 129.0, 118.0, 126.0, 129.0, 117.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [140.0, 129.0, 138.0, 138.0, 139.0, 128.0, 143.0, 140.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.9}, {"lowerIsBetter": true, "replicates": [73.0, 65.0, 67.0, 67.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1514.8}]} 14:49:40 INFO - Return code: 0 14:49:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:49:40 ERROR - # TBPL SUCCESS # 14:49:40 INFO - Running post-action listener: _resource_record_post_action 14:49:40 INFO - Running post-run listener: _resource_record_post_run 14:49:41 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 519921664; Read time: 0; Write time: 364512 14:49:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232390656; Read time: 0; Write time: 223416 14:49:41 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 287531008; Read time: 0; Write time: 141096 14:49:41 INFO - Running post-run listener: _upload_blobber_files 14:49:41 INFO - Blob upload gear active. 14:49:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:49:41 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 14:49:41 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'] 14:49:41 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 14:49:42 INFO - (blobuploader) - INFO - Open directory for files ... 14:49:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:49:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:43 INFO - (blobuploader) - INFO - Done attempting. 14:49:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:49:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:49:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:49:43 INFO - (blobuploader) - INFO - Done attempting. 14:49:43 INFO - (blobuploader) - INFO - Iteration through files over. 14:49:43 INFO - Return code: 0 14:49:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:49:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:49:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78e0fea427184f658c910a5e6ae1a83fb0a3d5a45057578bc8d0ba45e075fcf8fae0e6109d92ceae9e099ebc0899bc9030ad61cd6ba4396e53455d8f2eb45742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45c8961200fd62f34ebb85e8d706e05fc96cda69711919689acc0cdc4485b7ba69dec45b018a95259d40e5ec917cdbea3de4a3875b76a80b3b36436103943080"} 14:49:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:49:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:49:43 INFO - Contents: 14:49:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78e0fea427184f658c910a5e6ae1a83fb0a3d5a45057578bc8d0ba45e075fcf8fae0e6109d92ceae9e099ebc0899bc9030ad61cd6ba4396e53455d8f2eb45742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45c8961200fd62f34ebb85e8d706e05fc96cda69711919689acc0cdc4485b7ba69dec45b018a95259d40e5ec917cdbea3de4a3875b76a80b3b36436103943080"} 14:49:43 INFO - Running post-run listener: copy_logs_to_upload_dir 14:49:43 INFO - Copying logs to upload dir... 14:49:43 INFO - mkdir: /builds/slave/test/build/upload/logs 14:49:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.233315 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-03-12 14:49:43.755769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 14:49:43.761396) ========= 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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 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/78e0fea427184f658c910a5e6ae1a83fb0a3d5a45057578bc8d0ba45e075fcf8fae0e6109d92ceae9e099ebc0899bc9030ad61cd6ba4396e53455d8f2eb45742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45c8961200fd62f34ebb85e8d706e05fc96cda69711919689acc0cdc4485b7ba69dec45b018a95259d40e5ec917cdbea3de4a3875b76a80b3b36436103943080"} build_url:https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/Fe5qEsr6SvOqgADbEkSt5w/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/78e0fea427184f658c910a5e6ae1a83fb0a3d5a45057578bc8d0ba45e075fcf8fae0e6109d92ceae9e099ebc0899bc9030ad61cd6ba4396e53455d8f2eb45742", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/45c8961200fd62f34ebb85e8d706e05fc96cda69711919689acc0cdc4485b7ba69dec45b018a95259d40e5ec917cdbea3de4a3875b76a80b3b36436103943080"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 14:49:43.786288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:49:43.786614) ========= 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=20e666a3d4cfbb71505a330e000001b4-1457821015.113684-1090865613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 14:49:43.870403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 14:49:43.870730) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 14:49:43.871027) ========= ========= Total master_lag: 0.34 =========