builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1458338710.02 results: success (0) buildid: 20160318142139 builduid: 4b5dd9781d554b34bee995c940996562 revision: dac4bc7e3d2304697360cf1deb1b92044031f608 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.018745) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.019406) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.019728) ========= 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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006267 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.046152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.046427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.062198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.062502) ========= 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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.113149) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.113664) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.114261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.114536) ========= 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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 15:05:10-- 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% 224M=0s 2016-03-18 15:05:10 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091462 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.281675) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.281975) ========= 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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022087 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.321968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.322283) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dac4bc7e3d2304697360cf1deb1b92044031f608 --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 dac4bc7e3d2304697360cf1deb1b92044031f608 --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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 15:05:10,342 truncating revision to first 12 chars 2016-03-18 15:05:10,342 Setting DEBUG logging. 2016-03-18 15:05:10,342 attempt 1/10 2016-03-18 15:05:10,342 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dac4bc7e3d23?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 15:05:10,603 unpacking tar archive at: fx-team-dac4bc7e3d23/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563878 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.898785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.899143) ========= echo dac4bc7e3d2304697360cf1deb1b92044031f608 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dac4bc7e3d2304697360cf1deb1b92044031f608'] 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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dac4bc7e3d2304697360cf1deb1b92044031f608 program finished with exit code 0 elapsedTime=0.003725 script_repo_revision: 'dac4bc7e3d2304697360cf1deb1b92044031f608' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.949451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.949761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 15:05:10.963081) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-03-18 15:05:10.963371) ========= /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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:11 INFO - MultiFileLogger online at 20160318 15:05:11 in /builds/slave/test 15:05:11 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 15:05:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:11 INFO - {'append_to_log': False, 15:05:11 INFO - 'base_work_dir': '/builds/slave/test', 15:05:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:05:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:11 INFO - 'branch': 'Fx-Team-Non-PGO', 15:05:11 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:11 INFO - 'config_files': ('talos/linux_config.py',), 15:05:11 INFO - 'default_actions': ('clobber', 15:05:11 INFO - 'read-buildbot-config', 15:05:11 INFO - 'download-and-extract', 15:05:11 INFO - 'populate-webroot', 15:05:11 INFO - 'create-virtualenv', 15:05:11 INFO - 'install', 15:05:11 INFO - 'run-tests'), 15:05:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:11 INFO - 'download_minidump_stackwalk': True, 15:05:11 INFO - 'download_symbols': 'ondemand', 15:05:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:11 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:11 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:11 INFO - 'installer_path': 'installer.exe', 15:05:11 INFO - 'log_level': 'info', 15:05:11 INFO - 'log_name': 'talos', 15:05:11 INFO - 'log_to_console': True, 15:05:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:11 INFO - 'opt_config_files': (), 15:05:11 INFO - 'pip_index': False, 15:05:11 INFO - 'sps_profile': False, 15:05:11 INFO - 'sps_profile_interval': 0, 15:05:11 INFO - 'suite': 'dromaeojs', 15:05:11 INFO - 'system_bits': '32', 15:05:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:11 INFO - 'title': 'talos-linux64-ix-016', 15:05:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:11 INFO - 'use_talos_json': True, 15:05:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:11 INFO - 'work_dir': 'build'} 15:05:11 INFO - ##### 15:05:11 INFO - ##### Running clobber step. 15:05:11 INFO - ##### 15:05:11 INFO - Running pre-action listener: _resource_record_pre_action 15:05:11 INFO - Running main action method: clobber 15:05:11 INFO - rmtree: /builds/slave/test/build 15:05:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:12 INFO - Running post-action listener: _resource_record_post_action 15:05:12 INFO - ##### 15:05:12 INFO - ##### Running read-buildbot-config step. 15:05:12 INFO - ##### 15:05:12 INFO - Running pre-action listener: _resource_record_pre_action 15:05:12 INFO - Running main action method: read_buildbot_config 15:05:12 INFO - Using buildbot properties: 15:05:12 INFO - { 15:05:12 INFO - "project": "", 15:05:12 INFO - "product": "firefox", 15:05:12 INFO - "script_repo_revision": "production", 15:05:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:05:12 INFO - "repository": "", 15:05:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:05:12 INFO - "buildid": "20160318142139", 15:05:12 INFO - "pgo_build": "False", 15:05:12 INFO - "basedir": "/builds/slave/test", 15:05:12 INFO - "buildnumber": 2657, 15:05:12 INFO - "slavename": "talos-linux64-ix-016", 15:05:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:05:12 INFO - "platform": "ubuntu64_hw", 15:05:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:05:12 INFO - "branch": "fx-team", 15:05:12 INFO - "repo_path": "integration/fx-team", 15:05:12 INFO - "revision": "dac4bc7e3d2304697360cf1deb1b92044031f608", 15:05:12 INFO - "stage_platform": "linux64", 15:05:12 INFO - "builduid": "4b5dd9781d554b34bee995c940996562", 15:05:12 INFO - "slavebuilddir": "test" 15:05:12 INFO - } 15:05:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:05:12 INFO - Running post-action listener: _resource_record_post_action 15:05:12 INFO - ##### 15:05:12 INFO - ##### Running download-and-extract step. 15:05:12 INFO - ##### 15:05:12 INFO - Running pre-action listener: _resource_record_pre_action 15:05:12 INFO - Running main action method: download_and_extract 15:05:12 INFO - mkdir: /builds/slave/test/build/tests 15:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:12 INFO - https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:05:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:05:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:05:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:15 INFO - Downloaded 1361 bytes. 15:05:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:05:15 INFO - Using the following test package requirements: 15:05:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:05:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:05:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:15 INFO - u'jsshell-linux-x86_64.zip'], 15:05:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:05:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:05:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:05:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:05:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:05:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:05:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:05:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:05:15 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')]} 15:05:15 INFO - https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:18 INFO - Downloaded 22009824 bytes. 15:05:18 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'] 15:05:18 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 15:05:20 INFO - Return code: 0 15:05:20 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 15:05:20 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')]} 15:05:20 INFO - https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:25 INFO - Downloaded 22009824 bytes. 15:05:25 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'] 15:05:25 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 15:05:27 INFO - Return code: 0 15:05: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')]} 15:05:27 INFO - https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:05:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:05:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:28 INFO - Downloaded 10846565 bytes. 15:05:28 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'] 15:05:28 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 15:05:28 INFO - Return code: 0 15:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:28 INFO - https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LST8nzsdSzWojQ6GS788Dw/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 15:05:30 INFO - Downloaded 54150231 bytes. 15:05:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:05:30 INFO - mkdir: /builds/slave/test/properties 15:05:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:05:30 INFO - Writing to file /builds/slave/test/properties/build_url 15:05:30 INFO - Contents: 15:05:30 INFO - build_url:https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:05:31 INFO - Running post-action listener: _resource_record_post_action 15:05:31 INFO - Running post-action listener: set_extra_try_arguments 15:05:31 INFO - ##### 15:05:31 INFO - ##### Running populate-webroot step. 15:05:31 INFO - ##### 15:05:31 INFO - Running pre-action listener: _resource_record_pre_action 15:05:31 INFO - Running main action method: populate_webroot 15:05:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:05:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:05:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:05:31 INFO - '--tppagecycles', 15:05:31 INFO - '7'], 15:05:31 INFO - 'tests': ['tsvgm']}}, 15:05:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:05:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:05:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:05:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:05:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:05:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'tests': ['damp', 'tps']}, 15:05:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['damp', 'tps']}, 15:05:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:05:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:05:31 INFO - 'other': {'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other_l64': {'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'other_nol64': {'tests': ['a11yr', 15:05:31 INFO - 'ts_paint', 15:05:31 INFO - 'tpaint', 15:05:31 INFO - 'sessionrestore', 15:05:31 INFO - 'sessionrestore_no_auto_restore', 15:05:31 INFO - 'tabpaint']}, 15:05:31 INFO - 'svgr': {'tests': ['tsvgx', 15:05:31 INFO - 'tsvgr_opacity', 15:05:31 INFO - 'tart', 15:05:31 INFO - 'tscrollx', 15:05:31 INFO - 'cart']}, 15:05:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['tsvgx', 15:05:31 INFO - 'tsvgr_opacity', 15:05:31 INFO - 'tart', 15:05:31 INFO - 'tscrollx', 15:05:31 INFO - 'cart']}, 15:05:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'tests': ['tp5o']}, 15:05:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--e10s'], 15:05:31 INFO - 'tests': ['tp5o']}, 15:05:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--xperf_path', 15:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:31 INFO - 'tests': ['tp5n']}, 15:05:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:05:31 INFO - 'talos_options': ['--e10s', 15:05:31 INFO - '--xperf_path', 15:05:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:05:31 INFO - 'tests': ['tp5n']}}, 15:05:31 INFO - 'talos.zip': {'path': '', 15:05:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:05:31 INFO - Running post-action listener: _resource_record_post_action 15:05:31 INFO - ##### 15:05:31 INFO - ##### Running create-virtualenv step. 15:05:31 INFO - ##### 15:05:31 INFO - Running pre-action listener: _resource_record_pre_action 15:05:31 INFO - Running main action method: create_virtualenv 15:05:31 INFO - Creating virtualenv /builds/slave/test/build/venv 15:05:31 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 15:05:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:05:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:05:31 INFO - Using real prefix '/usr' 15:05:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:05:31 INFO - Installing distribute.............................................................................................................................................................................................done. 15:05:33 INFO - Installing pip.................done. 15:05:33 INFO - Return code: 0 15:05:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:33 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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:33 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 15:05:33 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 15:05:33 INFO - Using env: {'DISPLAY': ':0', 15:05:33 INFO - 'HOME': '/home/cltbld', 15:05:33 INFO - 'LANG': 'en_US.UTF-8', 15:05:33 INFO - 'LANGUAGE': 'en_US:en', 15:05:33 INFO - 'LOGNAME': 'cltbld', 15:05:33 INFO - 'MAIL': '/var/mail/cltbld', 15:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:33 INFO - 'MOZ_NO_REMOTE': '1', 15:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:33 INFO - 'NO_EM_RESTART': '1', 15:05:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:33 INFO - 'PWD': '/builds/slave/test', 15:05:33 INFO - 'SHELL': '/bin/bash', 15:05:33 INFO - 'SHLVL': '1', 15:05:33 INFO - 'TERM': 'linux', 15:05:33 INFO - 'TMOUT': '86400', 15:05:33 INFO - 'USER': 'cltbld', 15:05:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:33 INFO - '_': '/tools/buildbot/bin/python'} 15:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:34 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 15:05:34 INFO - Cleaning up... 15:05:34 INFO - Return code: 0 15:05:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:34 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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:34 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 15:05:34 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 15:05:34 INFO - Using env: {'DISPLAY': ':0', 15:05:34 INFO - 'HOME': '/home/cltbld', 15:05:34 INFO - 'LANG': 'en_US.UTF-8', 15:05:34 INFO - 'LANGUAGE': 'en_US:en', 15:05:34 INFO - 'LOGNAME': 'cltbld', 15:05:34 INFO - 'MAIL': '/var/mail/cltbld', 15:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:34 INFO - 'MOZ_NO_REMOTE': '1', 15:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:34 INFO - 'NO_EM_RESTART': '1', 15:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:34 INFO - 'PWD': '/builds/slave/test', 15:05:34 INFO - 'SHELL': '/bin/bash', 15:05:34 INFO - 'SHLVL': '1', 15:05:34 INFO - 'TERM': 'linux', 15:05:34 INFO - 'TMOUT': '86400', 15:05:34 INFO - 'USER': 'cltbld', 15:05:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:34 INFO - '_': '/tools/buildbot/bin/python'} 15:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:34 INFO - Downloading/unpacking psutil>=0.7.1 15:05:34 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 15:05:34 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 15:05:34 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 15:05:34 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 15:05:34 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 15:05:34 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 15:05:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:05:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:36 INFO - Installing collected packages: psutil 15:05:36 INFO - Running setup.py install for psutil 15:05:36 INFO - building 'psutil._psutil_linux' extension 15:05:36 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 15:05:36 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 15:05:36 INFO - building 'psutil._psutil_posix' extension 15:05:36 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 15:05:36 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 15:05:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:05:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:05:36 INFO - Successfully installed psutil 15:05:36 INFO - Cleaning up... 15:05:36 INFO - Return code: 0 15:05:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:36 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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:36 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 15:05:36 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 15:05:36 INFO - Using env: {'DISPLAY': ':0', 15:05:36 INFO - 'HOME': '/home/cltbld', 15:05:36 INFO - 'LANG': 'en_US.UTF-8', 15:05:36 INFO - 'LANGUAGE': 'en_US:en', 15:05:36 INFO - 'LOGNAME': 'cltbld', 15:05:36 INFO - 'MAIL': '/var/mail/cltbld', 15:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:36 INFO - 'MOZ_NO_REMOTE': '1', 15:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:36 INFO - 'NO_EM_RESTART': '1', 15:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:36 INFO - 'PWD': '/builds/slave/test', 15:05:36 INFO - 'SHELL': '/bin/bash', 15:05:36 INFO - 'SHLVL': '1', 15:05:36 INFO - 'TERM': 'linux', 15:05:36 INFO - 'TMOUT': '86400', 15:05:36 INFO - 'USER': 'cltbld', 15:05:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:36 INFO - '_': '/tools/buildbot/bin/python'} 15:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:05:36 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 15:05:36 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 15:05:36 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 15:05:36 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 15:05:36 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 15:05:36 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 15:05:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:05:38 INFO - Installing collected packages: mozsystemmonitor 15:05:38 INFO - Running setup.py install for mozsystemmonitor 15:05:38 INFO - Successfully installed mozsystemmonitor 15:05:38 INFO - Cleaning up... 15:05:38 INFO - Return code: 0 15:05:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:05:38 INFO - Using env: {'DISPLAY': ':0', 15:05:38 INFO - 'HOME': '/home/cltbld', 15:05:38 INFO - 'LANG': 'en_US.UTF-8', 15:05:38 INFO - 'LANGUAGE': 'en_US:en', 15:05:38 INFO - 'LOGNAME': 'cltbld', 15:05:38 INFO - 'MAIL': '/var/mail/cltbld', 15:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:38 INFO - 'MOZ_NO_REMOTE': '1', 15:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:38 INFO - 'NO_EM_RESTART': '1', 15:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:38 INFO - 'PWD': '/builds/slave/test', 15:05:38 INFO - 'SHELL': '/bin/bash', 15:05:38 INFO - 'SHLVL': '1', 15:05:38 INFO - 'TERM': 'linux', 15:05:38 INFO - 'TMOUT': '86400', 15:05:38 INFO - 'USER': 'cltbld', 15:05:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:38 INFO - '_': '/tools/buildbot/bin/python'} 15:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:39 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 15:05:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:05:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:05:41 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 15:05:41 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 15:05:41 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 15:05:41 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 15:05:41 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 15:05:41 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 15:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:05:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:05:41 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 15:05:41 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 15:05:41 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 15:05:41 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 15:05:41 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 15:05:41 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 15:05:41 INFO - Downloading docopt-0.6.1.tar.gz 15:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:05:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:05:41 INFO - Running setup.py install for blobuploader 15:05:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:05:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:05:41 INFO - Running setup.py install for requests 15:05:42 INFO - Running setup.py install for docopt 15:05:42 INFO - Successfully installed blobuploader requests docopt 15:05:42 INFO - Cleaning up... 15:05:42 INFO - Return code: 0 15:05:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05: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')]} 15:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05: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')]} 15:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:42 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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:42 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 15:05:42 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 15:05:42 INFO - Using env: {'DISPLAY': ':0', 15:05:42 INFO - 'HOME': '/home/cltbld', 15:05:42 INFO - 'LANG': 'en_US.UTF-8', 15:05:42 INFO - 'LANGUAGE': 'en_US:en', 15:05:42 INFO - 'LOGNAME': 'cltbld', 15:05:42 INFO - 'MAIL': '/var/mail/cltbld', 15:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:42 INFO - 'MOZ_NO_REMOTE': '1', 15:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:42 INFO - 'NO_EM_RESTART': '1', 15:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:42 INFO - 'PWD': '/builds/slave/test', 15:05:42 INFO - 'SHELL': '/bin/bash', 15:05:42 INFO - 'SHLVL': '1', 15:05:42 INFO - 'TERM': 'linux', 15:05:42 INFO - 'TMOUT': '86400', 15:05:42 INFO - 'USER': 'cltbld', 15:05:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:42 INFO - '_': '/tools/buildbot/bin/python'} 15:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:42 INFO - Running setup.py (path:/tmp/pip-2fttV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:42 INFO - Running setup.py (path:/tmp/pip-Z3Y3hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:42 INFO - Running setup.py (path:/tmp/pip-NixWOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:42 INFO - Running setup.py (path:/tmp/pip-IUGoYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:42 INFO - Running setup.py (path:/tmp/pip-wX3Afv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:42 INFO - Running setup.py (path:/tmp/pip-keV5XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:43 INFO - Running setup.py (path:/tmp/pip-g6lVRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:43 INFO - Running setup.py (path:/tmp/pip-dgxMB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:43 INFO - Running setup.py (path:/tmp/pip-RD8w2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:43 INFO - Running setup.py (path:/tmp/pip-KXUWTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:43 INFO - Running setup.py (path:/tmp/pip-p8YEiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:43 INFO - Running setup.py (path:/tmp/pip-HJaxzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:43 INFO - Running setup.py (path:/tmp/pip-U9cFR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:43 INFO - Running setup.py (path:/tmp/pip-Gp7o3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:43 INFO - Running setup.py (path:/tmp/pip-bXDxTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:43 INFO - Running setup.py (path:/tmp/pip-dCr2hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:43 INFO - Running setup.py (path:/tmp/pip-wwZx10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:05:43 INFO - Running setup.py install for manifestparser 15:05:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:05:43 INFO - Running setup.py install for mozcrash 15:05:44 INFO - Running setup.py install for mozdebug 15:05:44 INFO - Running setup.py install for mozdevice 15:05:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Running setup.py install for mozfile 15:05:44 INFO - Running setup.py install for mozhttpd 15:05:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Running setup.py install for mozinfo 15:05:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Running setup.py install for mozInstall 15:05:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Running setup.py install for mozleak 15:05:44 INFO - Running setup.py install for mozlog 15:05:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Running setup.py install for moznetwork 15:05:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:05:44 INFO - Running setup.py install for mozprocess 15:05:45 INFO - Running setup.py install for mozprofile 15:05:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:05:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:05:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:05:45 INFO - Running setup.py install for mozrunner 15:05:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:05:45 INFO - Running setup.py install for mozscreenshot 15:05:45 INFO - Running setup.py install for moztest 15:05:45 INFO - Running setup.py install for mozversion 15:05:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:05:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:05:45 INFO - Cleaning up... 15:05:45 INFO - Return code: 0 15:05:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:45 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')]} 15:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:45 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')]} 15:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:45 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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:45 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 15:05:45 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 15:05:45 INFO - Using env: {'DISPLAY': ':0', 15:05:45 INFO - 'HOME': '/home/cltbld', 15:05:45 INFO - 'LANG': 'en_US.UTF-8', 15:05:45 INFO - 'LANGUAGE': 'en_US:en', 15:05:45 INFO - 'LOGNAME': 'cltbld', 15:05:45 INFO - 'MAIL': '/var/mail/cltbld', 15:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:45 INFO - 'MOZ_NO_REMOTE': '1', 15:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:45 INFO - 'NO_EM_RESTART': '1', 15:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:45 INFO - 'PWD': '/builds/slave/test', 15:05:45 INFO - 'SHELL': '/bin/bash', 15:05:45 INFO - 'SHLVL': '1', 15:05:45 INFO - 'TERM': 'linux', 15:05:45 INFO - 'TMOUT': '86400', 15:05:45 INFO - 'USER': 'cltbld', 15:05:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:45 INFO - '_': '/tools/buildbot/bin/python'} 15:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:05:45 INFO - Running setup.py (path:/tmp/pip-2Hjfe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:05:45 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)) 15:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:05:45 INFO - Running setup.py (path:/tmp/pip-wnZ63e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:05:45 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)) 15:05:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:05:45 INFO - Running setup.py (path:/tmp/pip-BzJqIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:05:46 INFO - Running setup.py (path:/tmp/pip-DTYmRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:05:46 INFO - Running setup.py (path:/tmp/pip-iVL5tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:05:46 INFO - Running setup.py (path:/tmp/pip-ioznaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:05:46 INFO - Running setup.py (path:/tmp/pip-SqjV3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:05:46 INFO - Running setup.py (path:/tmp/pip-Xq4vTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:05:46 INFO - Running setup.py (path:/tmp/pip-ghZQKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:05:46 INFO - Running setup.py (path:/tmp/pip-rZIZOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:05:46 INFO - Running setup.py (path:/tmp/pip-_coCLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:05:46 INFO - Running setup.py (path:/tmp/pip-VEaPqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:05:46 INFO - Running setup.py (path:/tmp/pip-vAPcUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:05:46 INFO - Running setup.py (path:/tmp/pip-eIhtoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:46 INFO - Running setup.py (path:/tmp/pip-CDvktu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:05:46 INFO - Running setup.py (path:/tmp/pip-Whvqvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:05:46 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)) 15:05:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:05:46 INFO - Running setup.py (path:/tmp/pip-_GQ7Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 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)) 15:05:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:05:47 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 15:05:47 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 15:05:47 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 15:05:47 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 15:05:47 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 15:05:47 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 15:05:48 INFO - Downloading blessings-1.6.tar.gz 15:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:05:48 INFO - Installing collected packages: blessings 15:05:48 INFO - Running setup.py install for blessings 15:05:49 INFO - Successfully installed blessings 15:05:49 INFO - Cleaning up... 15:05:49 INFO - Return code: 0 15:05:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:49 INFO - Reading from file tmpfile_stdout 15:05:49 INFO - Current package versions: 15:05:49 INFO - argparse == 1.2.1 15:05:49 INFO - blessings == 1.6 15:05:49 INFO - blobuploader == 1.2.4 15:05:49 INFO - docopt == 0.6.1 15:05:49 INFO - manifestparser == 1.1 15:05:49 INFO - mozInstall == 1.12 15:05:49 INFO - mozcrash == 0.17 15:05:49 INFO - mozdebug == 0.1 15:05:49 INFO - mozdevice == 0.48 15:05:49 INFO - mozfile == 1.2 15:05:49 INFO - mozhttpd == 0.7 15:05:49 INFO - mozinfo == 0.9 15:05:49 INFO - mozleak == 0.1 15:05:49 INFO - mozlog == 3.1 15:05:49 INFO - moznetwork == 0.27 15:05:49 INFO - mozprocess == 0.22 15:05:49 INFO - mozprofile == 0.28 15:05:49 INFO - mozrunner == 6.11 15:05:49 INFO - mozscreenshot == 0.1 15:05:49 INFO - mozsystemmonitor == 0.0 15:05:49 INFO - moztest == 0.7 15:05:49 INFO - mozversion == 1.4 15:05:49 INFO - psutil == 3.1.1 15:05:49 INFO - requests == 1.2.3 15:05:49 INFO - wsgiref == 0.1.2 15:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:49 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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:49 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 15:05:49 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 15:05:49 INFO - Using env: {'DISPLAY': ':0', 15:05:49 INFO - 'HOME': '/home/cltbld', 15:05:49 INFO - 'LANG': 'en_US.UTF-8', 15:05:49 INFO - 'LANGUAGE': 'en_US:en', 15:05:49 INFO - 'LOGNAME': 'cltbld', 15:05:49 INFO - 'MAIL': '/var/mail/cltbld', 15:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:49 INFO - 'MOZ_NO_REMOTE': '1', 15:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:49 INFO - 'NO_EM_RESTART': '1', 15:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:49 INFO - 'PWD': '/builds/slave/test', 15:05:49 INFO - 'SHELL': '/bin/bash', 15:05:49 INFO - 'SHLVL': '1', 15:05:49 INFO - 'TERM': 'linux', 15:05:49 INFO - 'TMOUT': '86400', 15:05:49 INFO - 'USER': 'cltbld', 15:05:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:49 INFO - '_': '/tools/buildbot/bin/python'} 15:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 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)) 15:05:49 INFO - Cleaning up... 15:05:49 INFO - Return code: 0 15:05:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:49 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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:49 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 15:05:49 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 15:05:49 INFO - Using env: {'DISPLAY': ':0', 15:05:49 INFO - 'HOME': '/home/cltbld', 15:05:49 INFO - 'LANG': 'en_US.UTF-8', 15:05:49 INFO - 'LANGUAGE': 'en_US:en', 15:05:49 INFO - 'LOGNAME': 'cltbld', 15:05:49 INFO - 'MAIL': '/var/mail/cltbld', 15:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:49 INFO - 'MOZ_NO_REMOTE': '1', 15:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:49 INFO - 'NO_EM_RESTART': '1', 15:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:49 INFO - 'PWD': '/builds/slave/test', 15:05:49 INFO - 'SHELL': '/bin/bash', 15:05:49 INFO - 'SHLVL': '1', 15:05:49 INFO - 'TERM': 'linux', 15:05:49 INFO - 'TMOUT': '86400', 15:05:49 INFO - 'USER': 'cltbld', 15:05:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:49 INFO - '_': '/tools/buildbot/bin/python'} 15:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:49 INFO - Downloading/unpacking jsonschema 15:05:49 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 15:05:49 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 15:05:49 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 15:05:49 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 15:05:49 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 15:05:49 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 15:05:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:05:51 INFO - Downloading/unpacking functools32 (from jsonschema) 15:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:05:51 INFO - warning: no files found matching '*.txt' 15:05:51 INFO - no previously-included directories found matching 'build' 15:05:51 INFO - no previously-included directories found matching 'dist' 15:05:51 INFO - no previously-included directories found matching '.git*' 15:05:51 INFO - Installing collected packages: jsonschema, functools32 15:05:51 INFO - Running setup.py install for functools32 15:05:52 INFO - warning: no files found matching '*.txt' 15:05:52 INFO - no previously-included directories found matching 'build' 15:05:52 INFO - no previously-included directories found matching 'dist' 15:05:52 INFO - no previously-included directories found matching '.git*' 15:05:52 INFO - Successfully installed jsonschema functools32 15:05:52 INFO - Cleaning up... 15:05:52 INFO - Return code: 0 15:05:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:05:52 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')]} 15:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:52 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')]} 15:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:05:52 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 0x7f6f5ff82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffb5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, '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': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', '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 15:05:52 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 15:05:52 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 15:05:52 INFO - Using env: {'DISPLAY': ':0', 15:05:52 INFO - 'HOME': '/home/cltbld', 15:05:52 INFO - 'LANG': 'en_US.UTF-8', 15:05:52 INFO - 'LANGUAGE': 'en_US:en', 15:05:52 INFO - 'LOGNAME': 'cltbld', 15:05:52 INFO - 'MAIL': '/var/mail/cltbld', 15:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:52 INFO - 'MOZ_NO_REMOTE': '1', 15:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:52 INFO - 'NO_EM_RESTART': '1', 15:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:52 INFO - 'PWD': '/builds/slave/test', 15:05:52 INFO - 'SHELL': '/bin/bash', 15:05:52 INFO - 'SHLVL': '1', 15:05:52 INFO - 'TERM': 'linux', 15:05:52 INFO - 'TMOUT': '86400', 15:05:52 INFO - 'USER': 'cltbld', 15:05:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:52 INFO - '_': '/tools/buildbot/bin/python'} 15:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:05:52 INFO - Downloading/unpacking flake8 15:05:52 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 15:05:52 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 15:05:52 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 15:05:52 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 15:05:52 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 15:05:52 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 15:05:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:05:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:05:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:05:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:05:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:05:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:05:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:05:54 INFO - no previously-included directories found matching 'docs/_build' 15:05:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:05:54 INFO - Running setup.py install for pep8 15:05:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:05:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:05:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:05:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:05:55 INFO - no previously-included directories found matching 'docs/_build' 15:05:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:05:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:05:55 INFO - Cleaning up... 15:05:55 INFO - Return code: 0 15:05:55 INFO - Running post-action listener: _resource_record_post_action 15:05:55 INFO - Running post-action listener: _start_resource_monitoring 15:05:55 INFO - Starting resource monitoring. 15:05:55 INFO - ##### 15:05:55 INFO - ##### Running install step. 15:05:55 INFO - ##### 15:05:55 INFO - Running pre-action listener: _resource_record_pre_action 15:05:55 INFO - Running main action method: install 15:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:05:55 INFO - Reading from file tmpfile_stdout 15:05:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:05:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:05:55 INFO - Reading from file tmpfile_stdout 15:05:55 INFO - Output received: 15:05:55 INFO - Usage: mozinstall [options] installer 15:05:55 INFO - Options: 15:05:55 INFO - -h, --help show this help message and exit 15:05:55 INFO - -d DEST, --destination=DEST 15:05:55 INFO - Directory to install application into. [default: 15:05:55 INFO - "/builds/slave/test"] 15:05:55 INFO - --app=APP Application being installed. [default: firefox] 15:05:55 INFO - mkdir: /builds/slave/test/build/application 15:05:55 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'] 15:05:55 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 15:06:11 INFO - Reading from file tmpfile_stdout 15:06:11 INFO - Output received: 15:06:11 INFO - /builds/slave/test/build/application/firefox/firefox 15:06:11 INFO - Running post-action listener: _resource_record_post_action 15:06:11 INFO - ##### 15:06:11 INFO - ##### Running run-tests step. 15:06:11 INFO - ##### 15:06:11 INFO - Running pre-action listener: _resource_record_pre_action 15:06:11 INFO - Running main action method: run_tests 15:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:06:11 INFO - Python 2.7.3 15:06:11 INFO - Return code: 0 15:06:11 INFO - grabbing minidump binary from tooltool 15:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:06:11 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 0x108a410>, '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 0x108b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:06:11 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 15:06:11 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 15:06:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:06:11 INFO - Return code: 0 15:06:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:06:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:06:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:06:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:06:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:06:12 INFO - Return code: 0 15:06:12 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/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 15:06:12 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/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 15:06:12 INFO - Using env: {'DISPLAY': ':0', 15:06:12 INFO - 'HOME': '/home/cltbld', 15:06:12 INFO - 'LANG': 'en_US.UTF-8', 15:06:12 INFO - 'LANGUAGE': 'en_US:en', 15:06:12 INFO - 'LOGNAME': 'cltbld', 15:06:12 INFO - 'MAIL': '/var/mail/cltbld', 15:06:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:06:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:06:12 INFO - 'MOZ_NO_REMOTE': '1', 15:06:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:06:12 INFO - 'NO_EM_RESTART': '1', 15:06:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:06:12 INFO - 'PWD': '/builds/slave/test', 15:06:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:06:12 INFO - 'SHELL': '/bin/bash', 15:06:12 INFO - 'SHLVL': '1', 15:06:12 INFO - 'TERM': 'linux', 15:06:12 INFO - 'TMOUT': '86400', 15:06:12 INFO - 'USER': 'cltbld', 15:06:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886', 15:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:06:12 INFO - '_': '/tools/buildbot/bin/python'} 15:06:12 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/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 15:06:12 INFO - mozversion application_buildid: 20160318142139 15:06:12 INFO - mozversion application_changeset: dac4bc7e3d2304697360cf1deb1b92044031f608 15:06:12 INFO - mozversion application_display_name: Nightly 15:06:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:06:12 INFO - mozversion application_name: Firefox 15:06:12 INFO - mozversion application_remotingname: firefox 15:06:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:06:12 INFO - mozversion application_vendor: Mozilla 15:06:12 INFO - mozversion application_version: 48.0a1 15:06:12 INFO - mozversion platform_buildid: 20160318142139 15:06:12 INFO - mozversion platform_changeset: dac4bc7e3d2304697360cf1deb1b92044031f608 15:06:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:06:12 INFO - mozversion platform_version: 48.0a1 15:06:12 INFO - using testdate: 1458338772 15:06:12 INFO - actual date: 1458338772 15:06:12 INFO - starting webserver on 'localhost:50271' 15:06:12 INFO - SUITE-START | Running 2 tests 15:06:12 INFO - TEST-START | dromaeo_css 15:06:12 INFO - operating with platform_type : linux_ 15:06:12 INFO - Initialising browser for dromaeo_css test... 15:06:12 INFO - TEST-INFO | started process 399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIZdYVD/profile http://localhost:50271/getInfo.html) 15:06:16 INFO - PROCESS | 399 | __metrics Screen width/height:1600/1200 15:06:16 INFO - PROCESS | 399 | colorDepth:24 15:06:16 INFO - PROCESS | 399 | Browser inner width/height: 1024/697 15:06:16 INFO - PROCESS | 399 | __metrics 15:06:17 ERROR - PROCESS | 399 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:06:18 INFO - TEST-INFO | 399: exit 0 15:06:18 INFO - Browser initialized. 15:06:18 INFO - Running cycle 1/1 for dromaeo_css test... 15:06:18 INFO - TEST-INFO | started process 493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIZdYVD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:30 INFO - PROCESS | 493 | RSS: Main: 155398144 15:06:30 INFO - PROCESS | 493 | 15:07:21 INFO - PROCESS | 493 | 1458338841850 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] 15:09:33 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50271/tests/dromaeo/cssquery-ext.html) 15:09:34 INFO - PROCESS | 493 | RSS: Main: 269496320 15:09:34 INFO - PROCESS | 493 | 15:12:37 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-ext.html (next: http://localhost:50271/tests/dromaeo/cssquery-jquery.html) 15:12:37 INFO - PROCESS | 493 | RSS: Main: 239017984 15:12:37 INFO - PROCESS | 493 | 15:15:39 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50271/tests/dromaeo/cssquery-mootools.html) 15:15:40 INFO - PROCESS | 493 | RSS: Main: 238854144 15:15:40 INFO - PROCESS | 493 | 15:18:42 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50271/tests/dromaeo/cssquery-prototype.html) 15:18:42 INFO - PROCESS | 493 | RSS: Main: 221089792 15:18:42 INFO - PROCESS | 493 | 15:21:45 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50271/tests/dromaeo/cssquery-yui.html) 15:21:46 INFO - PROCESS | 493 | RSS: Main: 203173888 15:21:46 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | Cycle 1(1): loaded http://localhost:50271/tests/dromaeo/cssquery-yui.html (next: http://localhost:50271/tests/dromaeo/cssquery-dojo.html) 15:24:48 INFO - PROCESS | 493 | RSS: Main: 269209600 15:24:48 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | __start_tp_report 15:24:48 INFO - PROCESS | 493 | _x_x_mozilla_page_load 15:24:48 INFO - PROCESS | 493 | _x_x_mozilla_page_load_details 15:24:48 INFO - PROCESS | 493 | |i|pagename|runs| 15:24:48 INFO - PROCESS | 493 | |0;dojo.html;2604.804639652026;2682.114902082313;2688.032308368988;2699.716529764376;2720.347116691994;4651.2092944199485;4687.132880417125;4724.716517008982;4747.643926705494;4751.121042607111;4727.338172655831;4750.334953106568;4757.762111894409;4764.547368000043;4774;4276.828926842923;4368.257396242639;4378.934315985262;4424.955750442503;4435.933460998088;4231.830726770925;4334.0681753423005;4402.075564131536;4410.316400957857;4411.5808998145285;4323.524412314659;4347.630451411634;4382.991911860258;4412.139632771611;4436.9556304436865;4338.913221735547;4349.7825108744755;4357.498887627931;4385.035292235703;4401.625861801751;4240.1307731914885;4338.479382474124;4340.175366680352;4344.522102568715;4393.340998850166;4587.174308624446;4597.494275629678;4612.769361531943;4613.331066995267;4636.235021221494;5064.215046667772;5136.9743151284;5174.715390653512;5188.558972487343;5194.974025129888;5180.041692286902;5193.714345710984;5194.168932970744;5194.896102077937;5196.714180720059;4634.58288754007;4840.806367745321;4842.467328593852;4844.103840789465;4887.242477416006;5309.681419114865;5343.70609616467;5390.4879036491475;5404;5414.91877621836;5041.344625198774;5051;5052.989402119517;5071.011152825164;5114.769835357343;4999.075171093359;5131.281620573122;5142.202958541432;5143.27994080829;5148;5046.7476626168545;5090.08378491875;5107.259447380109;5127.820526281562;5170.121079416508;5050.772715227824;5073.568746656576;5104.157813960729;5113;5130.486951304914;4314.8489802857375;4396;4402.075564131568;4430.291153415438;4467.597916187494;3808.352580061396;3810.7523011004196;3817.980910095487;3874.9225015499533;3925.1364699766004;4344.152890186383;4347.956520434818;4353.129374125125;4360.825566977349;4387.5393083726385;5043.621728370387;5081.2378143278065;5090.898182036412;5092.541671249605;5098.796048158032;4407.691461597721;4426.911461770746;4440.511543730187;4476.932846007313;4480.462344518679;4639.280911458729;4678.976605117021;4684.414448193976;4685.367475390847;4728.361671174416;4755.072760811747;4846.975765121152;4856.320115183948;4860.538248866352;4863.3434486343895;5121.539061484485;5139.717315547681;5143.974280128576;5168;5199.064168449715;4831.685940413862;4841.346418233494;4842.201036828884;4842.201036828884;4890.926636100533;4951.900961980668;5026.47222041695;5055.6713813602;5099.490050995019;5100.362454693163;5138.948610513997;5144.588432925432;5157.690538567698;5166.070107380708;5182.663126896739;4996.425411077627;5005.449400566008;5013.874653133701;5016.2224855147515;5058.671186372874;4878.341423907727;4950.975245123751;4998.475160108282;5004.524570165829;5032.3961124665275;4924.50754924519;4933.481984391731;4947.208446648519;4960.280759289811;4988.401391832858;5013.24801279811;5033.144365457954;5035.345405097314;5036.521530454601;5086.3896332440345;4879.121758083579;4906.656534042726;4921.753912304442;4985.052839960396;4997.925031124463 15:24:48 INFO - PROCESS | 493 | |1;ext.html;546.2025442853434;560.1429812387048;564.9773909224307;577.7457918515853;581.4476247564813;27246.86376568117;27670.584941225872;27704.445911081766;27707.168784936435;27764.444711105767;28005.439891202215;35124.2975140497;35701;35738;35806.462903056476;7704.614769261529;7870.685172593089;7876.054873415198;7877;7880.842383152333;7676.270754278335;7789.844203115934;7793.181715919832;7796.688132474695;7797.33722633574;7762.262585054411;7827.0607527096545;7840.098388685288;7847.372210223169;8021.358291336708;7866.960665196694;7912.683492660315;7960.761177164694;7967.920320796776;7968;7811.648475818602;7924.286814186751;7943.046834379854;7945.165757595485;7946.602669866484;38165;38596.421053684215;38660;38684.032899177466;38685.61314386848;3232.2242661761243;3342.8161451120177;3362.4451965425674;3810.12367155553;3855.20968201518;25736.87131564349;26225.344366390804;26496.367143385494;26609.73390266092;28585.99796028558;3417.2994536120036;3419.692227699519;3437.2094418283687;3460.1176699941607;3543.7696549724187;250254;251437;251927;252398;254183;51488.48511514837;52264.21603675948;52300.47699522956;52338.95322093537;52378.47621523736;62428.68785656043;62905.37094629087;63249.36750632527;63365.36634633595;63415.365846340945;12445.937770311271;12466.87533124657;12471.438785254686;12526.311052892179;12563.18339307942;10372.481375931324;10428.843567346496;10436.165106791439;10438;10439.530221140067;19186.328478503186;19278.807211927702;19339.51651208703;19342.709859352122;19958.20167193296;7757.806054848674;7851.882221766678;7960.761177164694;8027.317677997319;8042.919570804334;871.4814685262259;879.8636211387245;897.3673560140086;913.141646851957;986.7582442301539;25799.226023219333;26960.191194264204;27151;27496.862515687695;27677;987.5654711926729;994.1500017485091;1005.0000249751544;1007.2797949466167;1041.401194313273;14107.858921410654;14268.143911365143;14473.421063157355;14544.563663090124;14548.563543093724;282147;285116;285136;285343;286861;46221;46232.3065154023;46372;46484.302735458994;46564.7671761639;1154.7459558897028;1179.8761130081389;1212.8120141378101;1242.2049888071642;1277.0294576122214;27965.16104516868;29137.271568210963;29943;30205.69794302029;30354;40604;41127.794361028005;41252.1749565001;41275;41293.38059929164;255147;258429;259054;259834;260886;31986.68013319837;32020.19949501281;32636.510452342758;32721.34557308793;32727.509087364186;39575.80212098921;39641.40537891876;40314.395284070175;40405;40848.59151408448;35157.47263791096;39670.80164599274;40939;41100.79449602733;41707.7914610425;36511.81744091262;36828.447573285885;37099.62900370962;37199.81400092982;37351.81324093471;28507.572386413805;36610.63389366072;37265.25469490649;37745.81127094347;37828.81085594664;28285.57571636386;30011.69988300089;31200.843995779876;31933;32147.463778984762;24808.759562021467;24911.252662420156;24976.50046999086;25087.372815679024;25344.493110138064 15:24:48 INFO - PROCESS | 493 | |2;jquery.html;347.189312954252;354.60461585332354;363.9308531379038;364.2278369855906;369.3425702249996;16490.91754541227;16973.405930792425;17091.743623845636;17422;17435.3025878965;16533.421330253444;16702.66594668106;17209.741853872172;17215.82784172158;17233.396831110913;4494.842680506166;4912.214045752689;5055.115354812911;5059.620528460362;5061.569766569827;4960.635825148077;4980.377452818398;4987.875303117433;4996.400431948171;5013.4234563025175;4955.801767929279;4963.305137280783;4969.8012079516775;4970.428400733907;5199.922001169985;5168.9224661630105;5171.534561889429;5172.560332371753;5190.6107041972;5206.167013277895;4967.081089998325;4969.329140566014;5011.1481048221885;5016.372953380827;5017.573506251973;11636.941815290955;11774.529018839321;11926.701832454171;11947.641570752892;11953.701157471045;1852.9814701852945;1897.667908116088;1977.5253939054667;2002.2491565662876;2014.0817136057092;9200.263978881674;9486.810263794754;10238.846417303746;10679.786404271948;12840.486380544768;1799.5321216483678;1801.4955812372557;1845.2065611786927;1851.7685289338833;1883.1243471785685;53481.46518534804;55464.44535554673;57577;60320.698396508174;63163.36836631621;10187.490625468698;10458.738531536772;10484.213683973732;10601.946990265;10621.362718236931;13281.402336894864;13366.796988271102;13399.263040532669;13421.66445838862;13423.932880335537;6930.3762661360715;7020.403265722471;7045.084139061992;7100.289971002859;7110;6461.515386346043;6565.737370505126;6590.209174899042;6611.33886611335;6657;4385.693001489865;4499.6400287976885;4504.864854054384;4545;4552.931706024412;1780.8397244247822;1790.8656850736247;1808.3670715249557;1810.08590661715;1824.224704500582;735.7351353512731;858.802475430642;870.3950754225752;874.9431286966327;926.1988380051207;15917.602059948595;16090;16177.4337898173;16411.671766564603;16722.58193545171;882.3514716683233;887.973360799177;891.5943245823134;893.0890491698431;935.5930170375908;9200;9595.520223988773;9607.231421486264;9667.70996870095;9767.560459779326;372072;389959;392063;399535;403802;68269.65865170643;69003.65498172477;70087;70117.64941175363;70296;907.4237858959608;920.7099763574453;956.2445667922264;990.1187942730975;992.2359782967075;15015.324310406277;15133;15149.318280677617;15200.771988419961;15283.847161528241;32096.518552221267;33268.1682957928;33586.32827343391;33867.459940504064;34149;43904.56095439132;47079.52920470889;47108.52891471041;47232.05535889332;47565;7338.6697598607125;7455.813604659927;7495.7001719930595;7545.7358992435;7629.961850190713;8589.65641374338;11253.49359278818;11422.885771142515;11485.196036277715;11552.191346605658;9815.607375705178;9987.350822196535;10155.54300056514;10190.949045254727;10390.480475976323;9669.951650241705;9721.4653194075;9785;9885.456299903575;9995.750106247402;9830.361026533252;10085.798284034132;10109.443980581138;10294.742631434274;10344.32761870476;7438;7477.327040566375;7508.136564295176;7571.583562904093;7578.886316705364;10105.444200568745;10147.949260253652;10390.948045259725;10422.583096676048;10451.895481045092 15:24:48 INFO - PROCESS | 493 | |3;mootools.html;1255.6923553729337;1432.6275168456204;1433.8422773494913;1583.2400447785062;1786.1962117047333;7314.08573928259;7470.850582988337;7471.028766260392;7484.4012479001685;7496.287852653996;7304.196538380774;7488;7490.625468726569;7493.625318734069;7497.437692173082;1943.416974907522;1985.583027564206;2136.4979229880964;2207.5915955548194;2238.21662418154;2227.5544891021777;2234.642457206847;2237.552489502098;2239.1267405711706;2240.9887950560224;2186.9015894284717;2211.159759291467;2218.434299253688;2227.866328020316;2239.7984181423667;2147.7744836792226;2154.407537927075;2154.838387120972;2159.762426133124;2161.492049368397;2190.8028277455105;2204.603171429142;2208.6576580629867;2210.5910406574676;2213.435573928638;7629.923700762977;7648.617569121521;7652.1582625911105;7674.769756907302;7681.615919204018;4623.12160689468;4771.23660214364;4775.546323099335;4787.40157480315;4789.185838407444;3029.3486900316316;3058.266016156129;3195.984020079908;3217.501287300472;3225.645179030305;961.4423634292094;968.9224862011022;971.2375785008734;972.5137431284357;997.9800403991879;10685.519151638116;10695.144388448905;10710.46447677613;10722.839157412645;10734.409607471585;4232.343986682069;4328.675349348811;4340.52254252032;4421.823127074946;4424.424824772759;9222.44665320083;9246.167844893856;9258.768530786785;9267.073292670679;9268.165865072177;4696.483386827446;4697.906041879143;4710.128626204163;4720.811167553328;4725.054989002213;3635.1457407509215;3718.1076541629814;4181.289180839264;4216.515100763451;4250.404943307939;3652.251288485854;3722.032271609401;3723.7951912645067;3766.472693822867;3771.8868433947027;1174.1194104421684;1182.7344741127083;1183.5029287699188;1187.1630500497129;1205.9276443413423;1201.801702719059;1203.8555373355077;1206.90344772418;1217.4764851114105;1223.0338032953866;7237.312455316736;7335.4131669466315;7359.448041396917;7371.3734332582335;7388.852222955511;1036.9325993810528;1046.3094357723867;1052.9894701052892;1053.836655318427;1084.2681190196586;5639.915401268984;5671.376148623648;5732.283464566929;5739.282589676291;5745.195672605839;8942.284617230605;9050.411723237969;9219.262459003263;9280.767980800534;9360.625574976924;9278.396904201205;9416.387934784218;9495.525223738785;9503.477308748084;9538.093881081286;7156.212816590171;7276.781696549112;7412.0364352633815;7421.888671669929;7423.85152296951;6833.69248383814;6894.724211031703;6901.344372284826;6905.309469053054;6947.201071876799;8236.217559331853;8464.238218560113;8470.915290847013;8476.618552165044;8591.140885911358;8460.534670593177;8743.081976392386;8747.03782583928;8747.65009399617;8862.246709029547;6295.716692748746;6355.872882542416;6449.3550644937;6465.64438955862;6476.579022363531;7239.963800180965;7292.197858235484;7295.890561641473;7339.816504587428;7406.629668516445;6570.375814297634;6747.696353664195;6783.219929708147;6811.250762416031;6857.417119544894;6661.1340525733285;6716.630585317659;6751.426128779109;6786.59280443175;6810.8637827244165;6957.478189135733;6959.930400696131;7009.579425234502;7079.079719636415;7079.29207079288;6206.689665516797;6219.067139928866;6267.435930766253;6278.497720182466;6279.026750853625;6513.283538810632;6583.934160658332;6595.571287866273;6596.208454985433;6597.5381723280825 15:24:48 INFO - PROCESS | 493 | |4;prototype.html;321.1905996887843;321.61406312425095;324.832711153756;327.73126036649955;328.2122905027933;5330.813421530247;5413.350397952247;5422.566194704424;5433.945660543393;5441.891162176764;5334.199870019499;5357.223202635615;5366.034113859504;5370.62405631605;5381.112116500783;3919.176972835708;4056.3104272273786;4122.670186385082;4143.378493226025;4200.432941552889;4173.332266837307;4180.644645205161;4180.979095104535;4181.310083836179;4187.225363307783;4131.917361652765;4138.565450627686;4140.358244472111;4141.213169497786;4154.376843473473;3942.0933185367385;4029.717919745619;4082.7754473503946;4088.5093788745244;4111;3639.0538460000325;3643.2531331077066;3643.5627724672945;3652.3425783358985;3656.8171591420323;5132.307138536287;5143.7685304161405;5144.717040562805;5145.382554093533;5148.330717006803;4789.664723469358;4790.041991601694;4794.448638406593;4799.616030717534;4808;5620.606557540974;5631.2397826293745;5632.239647647556;5632.802851900164;5633.352164501053;4032.8185231664647;4033.3143365627916;4035.7982100894837;4041.2523683118716;4046.190761847613;5685.147227915804;5940.643561386288;5972.731227094748;5977.133315669247;5979.820605381802;4019.397090436458;4062.8171732272117;4063.1061166543313;4063.1264278180333;4066.34938409853;4115.1975364804175;4116.732412393185;4118.217538667644;4119.299719047769;4120.711550191518;4723.858284251478;4727.2436410174205;4728.4562275338085;4730.9763451182525;4735.431748190239;5680.602357834994;5683.147527870852;5683.175939488751;5693.857653558694;5697.202391665171;1403.4736973634888;1446.8263808343065;1448.7102579484144;1449.644837014938;1450.804141440892;882.4969767232744;934.2525979216599;943.099340130174;955.245356168633;970.4807927758616;4852.126617208865;4863.805447782049;4865.95134048655;4866.343043689128;4872.049950259665;5800.883982320414;5806.535477161901;5807.767689292466;5807.941920580824;5808.012637851575;4900.583450406684;4902.068606964736;4908.04293162837;4909.361782968263;4914.361133052752;3095.9226019349244;3114.8909788157757;3134.639516455591;3136.702013308732;3136.7490600751885;5438.592105592096;5439.156930675752;5443.374011988592;5443.673379597237;5446.509814116748;5778.855528611734;5952.464278214981;5952.523798096228;5955.464008239279;5965.613754498236;5398.838034858961;5418.051840927822;5427.457254274541;5436.266104075979;5440.347158341025;5799.507041901317;5802;5803.47768700819;5807.157962095557;5810.622309549865;5658.745356459051;5701.287339082614;5711.885762284648;5715.2855893013375;5731.799387021434;5437.510624043855;5450.2369668247275;5458.317710286215;5459.099248623933;5459.372172200089;3944.092858642471;4055.8377664893073;4067.471228740363;4071.959280407158;4077.959220407758;5752.13717942312;5768.278965129359;5770.422957704196;5780.682062486603;5784.045632470596;5577.832665020056;5583.944160558342;5588.133839254922;5588.133839254922;5593.776248949996;5529.723513824373;5585.134304182858;5585.245991791218;5591.440855914376;5594.300712410949;5460.099083651153;5480.753366098455;5490.3411590609385;5492.5605951524585;5503.091989821634;5514.862128446821;5686;5690.829275121753;5697.4302569742695;5707.258056452634;5547.944520554743;5593.272874526286;5594.86012849682;5597.720113994365;5603.915941260802 15:24:48 INFO - PROCESS | 493 | |5;yui.html;654.7839213059691;696.696936832478;702.4520873718499;746.8991686122375;761.9999999999998;11965.461554230058;12107.636770896865;12121.33332666703;12161.51353945841;12201.572944946929;11749.588764393247;11781.29312241266;11807.291562506256;11846.466908989094;11862.288262704244;642.8296501427126;778.1790211327047;780.9140994490616;800.0839039299998;803.0644299391203;802.7110240313483;803.120582961656;807.3016840433013;808.2241048593328;808.975730728079;840.5923127283263;843.4475418600827;845.9196376344269;846.2637505370305;846.3018010141627;675.223492983071;840.4117118017413;848.4866655673352;849.3120572336427;850.0564373545391;616.5838059309948;617.4473845907887;617.5769597825459;618.3877960818756;619.0899377914459;12141.514339426412;12173.2696038238;12187.32969686667;12240.387980601023;12257.080718946025;12230.816537751942;12454.128211025232;12611.306378149198;12613.684657883534;12626.494940202381;9850.852237216448;9905.653302134462;10065.295429319951;10070.848937265946;10092.747681307952;3347.8493467794005;3419.46998215277;3421.7775844570024;3465.861365545375;3470.4273794824076;43828.99999999968;43968.56031439709;44007.339889901676;44025;44041.559584404065;9895;9994;10124.088832005154;10129.290949633454;10271.537780799881;17887;17902.731459028124;17929.19318630665;17936.282548697905;17943.102844857705;6878.415334696507;6904.516683832084;7055.6119413431725;7065.293470652997;7081.291870812877;3802.942955855609;3805.6574908257835;3807.809609519513;3826.6364695354455;3828.349180639298;2988.701129886994;3029.3941211757738;3044.451998640266;3049.969500305013;3051.6572708008407;517.7799435240008;520.6485622204997;532.4888107416923;543.6058857328405;546.3198318093919;618.7964409224106;626.5614070150913;631.0754744299531;642.4121928435429;643.9742410303629;7872.527648341118;8281.792955176048;8292.013082665493;8347;8490.745277641681;605.5518916002127;609.1593600830826;609.5793902207463;615.0282553565356;647.8542327976262;3728.086618778362;3763.2849758546336;3786.280606684721;3812.4662547243406;3843.6540711336115;54658;55766.72116639472;55858;56149.15776263359;56373.71813140908;44255.55744442515;45361;45477;46317.30524042142;46404.071918561436;42199.36700949488;42447;43159;43212.3518147228;43269.35095973563;8039.919600804151;8123.959380203061;8230.135835737161;8243.876341854757;8402.957985210034;32396.35207295888;32469;32903.506447402826;33020;33647.831760841036;38008;38082;41824.581754182065;42907.7854610725;43536.78231608822;9996.518971604639;10127.392356458637;10366.806255022388;10389.584416623251;10491.632792852213;11541.307521548733;11583.131265155316;11755.588554400554;12069.094817888517;12194.57318993831;9591.472469013992;9652.083052110038;9718.659846905324;9765.560549775135;10060.84908726355;10544;10793.67618971432;10951.123910087015;10967.232293739362;11184;10103.898961010296;10238.846417303896;10432.582696692047;10483.21375896826;10557.260991730505;8329.541875196923;8723.302135829246;8855.512946787989;9095;9190.49452280131;8721.215090641872;8760.91239087601;8875.514855840374;9362.531873406439;9867.506624668882 15:24:48 INFO - PROCESS | 493 | __end_tp_report 15:24:48 INFO - PROCESS | 493 | __start_cc_report 15:24:48 INFO - PROCESS | 493 | _x_x_mozilla_cycle_collect,1004 15:24:48 INFO - PROCESS | 493 | __end_cc_report 15:24:48 INFO - PROCESS | 493 | __startTimestamp1458339888872__endTimestamp 15:24:48 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | ------- Summary: start ------- 15:24:48 INFO - PROCESS | 493 | Number of tests: 6 15:24:48 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | [#0] dojo.html Cycles:165 Average:4735.24 Median:4863.34 stddev:504.49 (10.4%) stddev-sans-first:477.55 15:24:48 INFO - PROCESS | 493 | Values: 2604.8 2682.1 2688.0 2699.7 2720.3 4651.2 4687.1 4724.7 4747.6 4751.1 4727.3 4750.3 4757.8 4764.5 4774.0 4276.8 4368.3 4378.9 4425.0 4435.9 4231.8 4334.1 4402.1 4410.3 4411.6 4323.5 4347.6 4383.0 4412.1 4437.0 4338.9 4349.8 4357.5 4385.0 4401.6 4240.1 4338.5 4340.2 4344.5 4393.3 4587.2 4597.5 4612.8 4613.3 4636.2 5064.2 5137.0 5174.7 5188.6 5195.0 5180.0 5193.7 5194.2 5194.9 5196.7 4634.6 4840.8 4842.5 4844.1 4887.2 5309.7 5343.7 5390.5 5404.0 5414.9 5041.3 5051.0 5053.0 5071.0 5114.8 4999.1 5131.3 5142.2 5143.3 5148.0 5046.7 5090.1 5107.3 5127.8 5170.1 5050.8 5073.6 5104.2 5113.0 5130.5 4314.8 4396.0 4402.1 4430.3 4467.6 3808.4 3810.8 3818.0 3874.9 3925.1 4344.2 4348.0 4353.1 4360.8 4387.5 5043.6 5081.2 5090.9 5092.5 5098.8 4407.7 4426.9 4440.5 4476.9 4480.5 4639.3 4679.0 4684.4 4685.4 4728.4 4755.1 4847.0 4856.3 4860.5 4863.3 5121.5 5139.7 5144.0 5168.0 5199.1 4831.7 4841.3 4842.2 4842.2 4890.9 4951.9 5026.5 5055.7 5099.5 5100.4 5138.9 5144.6 5157.7 5166.1 5182.7 4996.4 5005.4 5013.9 5016.2 5058.7 4878.3 4951.0 4998.5 5004.5 5032.4 4924.5 4933.5 4947.2 4960.3 4988.4 5013.2 5033.1 5035.3 5036.5 5086.4 4879.1 4906.7 4921.8 4985.1 4997.9 15:24:48 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | [#1] ext.html Cycles:180 Average:42698.19 Median:35719.50 stddev:69310.77 (194.0%) stddev-sans-first:69432.94 15:24:48 INFO - PROCESS | 493 | Values: 546.2 560.1 565.0 577.7 581.4 27246.9 27670.6 27704.4 27707.2 27764.4 28005.4 35124.3 35701.0 35738.0 35806.5 7704.6 7870.7 7876.1 7877.0 7880.8 7676.3 7789.8 7793.2 7796.7 7797.3 7762.3 7827.1 7840.1 7847.4 8021.4 7867.0 7912.7 7960.8 7967.9 7968.0 7811.6 7924.3 7943.0 7945.2 7946.6 38165.0 38596.4 38660.0 38684.0 38685.6 3232.2 3342.8 3362.4 3810.1 3855.2 25736.9 26225.3 26496.4 26609.7 28586.0 3417.3 3419.7 3437.2 3460.1 3543.8 250254.0 251437.0 251927.0 252398.0 254183.0 51488.5 52264.2 52300.5 52339.0 52378.5 62428.7 62905.4 63249.4 63365.4 63415.4 12445.9 12466.9 12471.4 12526.3 12563.2 10372.5 10428.8 10436.2 10438.0 10439.5 19186.3 19278.8 19339.5 19342.7 19958.2 7757.8 7851.9 7960.8 8027.3 8042.9 871.5 879.9 897.4 913.1 986.8 25799.2 26960.2 27151.0 27496.9 27677.0 987.6 994.2 1005.0 1007.3 1041.4 14107.9 14268.1 14473.4 14544.6 14548.6 282147.0 285116.0 285136.0 285343.0 286861.0 46221.0 46232.3 46372.0 46484.3 46564.8 1154.7 1179.9 1212.8 1242.2 1277.0 27965.2 29137.3 29943.0 30205.7 30354.0 40604.0 41127.8 41252.2 41275.0 41293.4 255147.0 258429.0 259054.0 259834.0 260886.0 31986.7 32020.2 32636.5 32721.3 32727.5 39575.8 39641.4 40314.4 40405.0 40848.6 35157.5 39670.8 40939.0 41100.8 41707.8 36511.8 36828.4 37099.6 37199.8 37351.8 28507.6 36610.6 37265.3 37745.8 37828.8 28285.6 30011.7 31200.8 31933.0 32147.5 24808.8 24911.3 24976.5 25087.4 25344.5 15:24:48 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | [#2] jquery.html Cycles:180 Average:23287.16 Median:25816.23 stddev:64287.65 (249.0%) stddev-sans-first:64444.92 15:24:48 INFO - PROCESS | 493 | Values: 347.2 354.6 363.9 364.2 369.3 16490.9 16973.4 17091.7 17422.0 17435.3 16533.4 16702.7 17209.7 17215.8 17233.4 4494.8 4912.2 5055.1 5059.6 5061.6 4960.6 4980.4 4987.9 4996.4 5013.4 4955.8 4963.3 4969.8 4970.4 5199.9 5168.9 5171.5 5172.6 5190.6 5206.2 4967.1 4969.3 5011.1 5016.4 5017.6 11636.9 11774.5 11926.7 11947.6 11953.7 1853.0 1897.7 1977.5 2002.2 2014.1 9200.3 9486.8 10238.8 10679.8 12840.5 1799.5 1801.5 1845.2 1851.8 1883.1 53481.5 55464.4 57577.0 60320.7 63163.4 10187.5 10458.7 10484.2 10601.9 10621.4 13281.4 13366.8 13399.3 13421.7 13423.9 6930.4 7020.4 7045.1 7100.3 7110.0 6461.5 6565.7 6590.2 6611.3 6657.0 4385.7 4499.6 4504.9 4545.0 4552.9 1780.8 1790.9 1808.4 1810.1 1824.2 735.7 858.8 870.4 874.9 926.2 15917.6 16090.0 16177.4 16411.7 16722.6 882.4 888.0 891.6 893.1 935.6 9200.0 9595.5 9607.2 9667.7 9767.6 372072.0 389959.0 392063.0 399535.0 403802.0 68269.7 69003.7 70087.0 70117.6 70296.0 907.4 920.7 956.2 990.1 992.2 15015.3 15133.0 15149.3 15200.8 15283.8 32096.5 33268.2 33586.3 33867.5 34149.0 43904.6 47079.5 47108.5 47232.1 47565.0 7338.7 7455.8 7495.7 7545.7 7630.0 8589.7 11253.5 11422.9 11485.2 11552.2 9815.6 9987.4 10155.5 10190.9 10390.5 9670.0 9721.5 9785.0 9885.5 9995.8 9830.4 10085.8 10109.4 10294.7 10344.3 7438.0 7477.3 7508.1 7571.6 7578.9 10105.4 10147.9 10390.9 10422.6 10451.9 15:24:48 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | [#3] mootools.html Cycles:180 Average:5393.55 Median:6325.79 stddev:2812.22 (44.5%) stddev-sans-first:2802.91 15:24:48 INFO - PROCESS | 493 | Values: 1255.7 1432.6 1433.8 1583.2 1786.2 7314.1 7470.9 7471.0 7484.4 7496.3 7304.2 7488.0 7490.6 7493.6 7497.4 1943.4 1985.6 2136.5 2207.6 2238.2 2227.6 2234.6 2237.6 2239.1 2241.0 2186.9 2211.2 2218.4 2227.9 2239.8 2147.8 2154.4 2154.8 2159.8 2161.5 2190.8 2204.6 2208.7 2210.6 2213.4 7629.9 7648.6 7652.2 7674.8 7681.6 4623.1 4771.2 4775.5 4787.4 4789.2 3029.3 3058.3 3196.0 3217.5 3225.6 961.4 968.9 971.2 972.5 998.0 10685.5 10695.1 10710.5 10722.8 10734.4 4232.3 4328.7 4340.5 4421.8 4424.4 9222.4 9246.2 9258.8 9267.1 9268.2 4696.5 4697.9 4710.1 4720.8 4725.1 3635.1 3718.1 4181.3 4216.5 4250.4 3652.3 3722.0 3723.8 3766.5 3771.9 1174.1 1182.7 1183.5 1187.2 1205.9 1201.8 1203.9 1206.9 1217.5 1223.0 7237.3 7335.4 7359.4 7371.4 7388.9 1036.9 1046.3 1053.0 1053.8 1084.3 5639.9 5671.4 5732.3 5739.3 5745.2 8942.3 9050.4 9219.3 9280.8 9360.6 9278.4 9416.4 9495.5 9503.5 9538.1 7156.2 7276.8 7412.0 7421.9 7423.9 6833.7 6894.7 6901.3 6905.3 6947.2 8236.2 8464.2 8470.9 8476.6 8591.1 8460.5 8743.1 8747.0 8747.7 8862.2 6295.7 6355.9 6449.4 6465.6 6476.6 7240.0 7292.2 7295.9 7339.8 7406.6 6570.4 6747.7 6783.2 6811.3 6857.4 6661.1 6716.6 6751.4 6786.6 6810.9 6957.5 6959.9 7009.6 7079.1 7079.3 6206.7 6219.1 6267.4 6278.5 6279.0 6513.3 6583.9 6595.6 6596.2 6597.5 15:24:48 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | [#4] prototype.html Cycles:180 Average:4662.45 Median:5389.98 stddev:1364.50 (25.3%) stddev-sans-first:1328.85 15:24:48 INFO - PROCESS | 493 | Values: 321.2 321.6 324.8 327.7 328.2 5330.8 5413.4 5422.6 5433.9 5441.9 5334.2 5357.2 5366.0 5370.6 5381.1 3919.2 4056.3 4122.7 4143.4 4200.4 4173.3 4180.6 4181.0 4181.3 4187.2 4131.9 4138.6 4140.4 4141.2 4154.4 3942.1 4029.7 4082.8 4088.5 4111.0 3639.1 3643.3 3643.6 3652.3 3656.8 5132.3 5143.8 5144.7 5145.4 5148.3 4789.7 4790.0 4794.4 4799.6 4808.0 5620.6 5631.2 5632.2 5632.8 5633.4 4032.8 4033.3 4035.8 4041.3 4046.2 5685.1 5940.6 5972.7 5977.1 5979.8 4019.4 4062.8 4063.1 4063.1 4066.3 4115.2 4116.7 4118.2 4119.3 4120.7 4723.9 4727.2 4728.5 4731.0 4735.4 5680.6 5683.1 5683.2 5693.9 5697.2 1403.5 1446.8 1448.7 1449.6 1450.8 882.5 934.3 943.1 955.2 970.5 4852.1 4863.8 4866.0 4866.3 4872.0 5800.9 5806.5 5807.8 5807.9 5808.0 4900.6 4902.1 4908.0 4909.4 4914.4 3095.9 3114.9 3134.6 3136.7 3136.7 5438.6 5439.2 5443.4 5443.7 5446.5 5778.9 5952.5 5952.5 5955.5 5965.6 5398.8 5418.1 5427.5 5436.3 5440.3 5799.5 5802.0 5803.5 5807.2 5810.6 5658.7 5701.3 5711.9 5715.3 5731.8 5437.5 5450.2 5458.3 5459.1 5459.4 3944.1 4055.8 4067.5 4072.0 4078.0 5752.1 5768.3 5770.4 5780.7 5784.0 5577.8 5583.9 5588.1 5588.1 5593.8 5529.7 5585.1 5585.2 5591.4 5594.3 5460.1 5480.8 5490.3 5492.6 5503.1 5514.9 5686.0 5690.8 5697.4 5707.3 5547.9 5593.3 5594.9 5597.7 5603.9 15:24:48 INFO - PROCESS | 493 | 15:24:48 INFO - PROCESS | 493 | [#5] yui.html Cycles:180 Average:12874.13 Median:44148.56 stddev:14788.68 (33.5%) stddev-sans-first:14801.70 15:24:48 INFO - PROCESS | 493 | Values: 654.8 696.7 702.5 746.9 762.0 11965.5 12107.6 12121.3 12161.5 12201.6 11749.6 11781.3 11807.3 11846.5 11862.3 642.8 778.2 780.9 800.1 803.1 802.7 803.1 807.3 808.2 809.0 840.6 843.4 845.9 846.3 846.3 675.2 840.4 848.5 849.3 850.1 616.6 617.4 617.6 618.4 619.1 12141.5 12173.3 12187.3 12240.4 12257.1 12230.8 12454.1 12611.3 12613.7 12626.5 9850.9 9905.7 10065.3 10070.8 10092.7 3347.8 3419.5 3421.8 3465.9 3470.4 43829.0 43968.6 44007.3 44025.0 44041.6 9895.0 9994.0 10124.1 10129.3 10271.5 17887.0 17902.7 17929.2 17936.3 17943.1 6878.4 6904.5 7055.6 7065.3 7081.3 3802.9 3805.7 3807.8 3826.6 3828.3 2988.7 3029.4 3044.5 3050.0 3051.7 517.8 520.6 532.5 543.6 546.3 618.8 626.6 631.1 642.4 644.0 7872.5 8281.8 8292.0 8347.0 8490.7 605.6 609.2 609.6 615.0 647.9 3728.1 3763.3 3786.3 3812.5 3843.7 54658.0 55766.7 55858.0 56149.2 56373.7 44255.6 45361.0 45477.0 46317.3 46404.1 42199.4 42447.0 43159.0 43212.4 43269.4 8039.9 8124.0 8230.1 8243.9 8403.0 32396.4 32469.0 32903.5 33020.0 33647.8 38008.0 38082.0 41824.6 42907.8 43536.8 9996.5 10127.4 10366.8 10389.6 10491.6 11541.3 11583.1 11755.6 12069.1 12194.6 9591.5 9652.1 9718.7 9765.6 10060.8 10544.0 10793.7 10951.1 10967.2 11184.0 10103.9 10238.8 10432.6 10483.2 10557.3 8329.5 8723.3 8855.5 9095.0 9190.5 8721.2 8760.9 8875.5 9362.5 9867.5 15:24:48 INFO - PROCESS | 493 | -------- Summary: end -------- 15:24:48 INFO - PROCESS | 493 | 15:24:49 INFO - TEST-INFO | 493: exit 0 15:24:49 INFO - TEST-OK | dromaeo_css | took 1117240ms 15:24:49 INFO - TEST-START | kraken 15:24:49 INFO - operating with platform_type : linux_ 15:24:49 INFO - Initialising browser for kraken test... 15:24:49 INFO - TEST-INFO | started process 678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUoy7Xl/profile http://localhost:50271/getInfo.html) 15:24:54 INFO - PROCESS | 678 | __metrics Screen width/height:1600/1200 15:24:54 INFO - PROCESS | 678 | colorDepth:24 15:24:54 INFO - PROCESS | 678 | Browser inner width/height: 1024/697 15:24:54 INFO - PROCESS | 678 | __metrics 15:24:54 ERROR - PROCESS | 678 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:24:55 INFO - PROCESS | 678 | 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. 15:24:55 INFO - TEST-INFO | 678: exit 0 15:24:55 INFO - Browser initialized. 15:24:55 INFO - Running cycle 1/1 for kraken test... 15:24:55 INFO - TEST-INFO | started process 761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUoy7Xl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:07 INFO - PROCESS | 761 | RSS: Main: 154550272 15:25:07 INFO - PROCESS | 761 | 15:25:10 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50271/tests/kraken/driver.html?testName=audio-beat-detection) 15:25:10 INFO - PROCESS | 761 | RSS: Main: 198270976 15:25:10 INFO - PROCESS | 761 | 15:25:13 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50271/tests/kraken/driver.html?testName=audio-dft) 15:25:14 INFO - PROCESS | 761 | RSS: Main: 189169664 15:25:14 INFO - PROCESS | 761 | 15:25:17 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50271/tests/kraken/driver.html?testName=audio-fft) 15:25:17 INFO - PROCESS | 761 | RSS: Main: 172433408 15:25:17 INFO - PROCESS | 761 | 15:25:19 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50271/tests/kraken/driver.html?testName=audio-oscillator) 15:25:20 INFO - PROCESS | 761 | RSS: Main: 174698496 15:25:20 INFO - PROCESS | 761 | 15:25:22 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:25:23 INFO - PROCESS | 761 | RSS: Main: 176181248 15:25:23 INFO - PROCESS | 761 | 15:25:26 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50271/tests/kraken/driver.html?testName=imaging-darkroom) 15:25:27 INFO - PROCESS | 761 | RSS: Main: 175915008 15:25:27 INFO - PROCESS | 761 | 15:25:30 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50271/tests/kraken/driver.html?testName=imaging-desaturate) 15:25:31 INFO - PROCESS | 761 | RSS: Main: 176914432 15:25:31 INFO - PROCESS | 761 | 15:25:33 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50271/tests/kraken/driver.html?testName=json-parse-financial) 15:25:34 INFO - PROCESS | 761 | RSS: Main: 177807360 15:25:34 INFO - PROCESS | 761 | 15:25:36 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:25:36 INFO - PROCESS | 761 | RSS: Main: 188522496 15:25:36 INFO - PROCESS | 761 | 15:25:38 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:25:39 INFO - PROCESS | 761 | RSS: Main: 185139200 15:25:39 INFO - PROCESS | 761 | 15:25:41 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:25:42 INFO - PROCESS | 761 | RSS: Main: 195903488 15:25:42 INFO - PROCESS | 761 | 15:25:44 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:25:45 INFO - PROCESS | 761 | RSS: Main: 200232960 15:25:45 INFO - PROCESS | 761 | 15:25:47 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:25:48 INFO - PROCESS | 761 | RSS: Main: 199712768 15:25:48 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | Cycle 1(1): loaded http://localhost:50271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50271/tests/kraken/driver.html?testName=ai-astar) 15:25:50 INFO - PROCESS | 761 | RSS: Main: 260165632 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | __start_tp_report 15:25:50 INFO - PROCESS | 761 | _x_x_mozilla_page_load 15:25:50 INFO - PROCESS | 761 | _x_x_mozilla_page_load_details 15:25:50 INFO - PROCESS | 761 | |i|pagename|runs| 15:25:50 INFO - PROCESS | 761 | |0;ai-astar;110;112;108;112;114;112;100;110;111;111 15:25:50 INFO - PROCESS | 761 | |1;audio-beat-detection;154;138;156;175;131;166;155;133;190;129 15:25:50 INFO - PROCESS | 761 | |2;audio-dft;161;164;161;163;160;159;163;161;163;162 15:25:50 INFO - PROCESS | 761 | |3;audio-fft;74;74;110;93;73;73;73;113;90;73 15:25:50 INFO - PROCESS | 761 | |4;audio-oscillator;93;93;135;94;94;93;138;94;94;131 15:25:50 INFO - PROCESS | 761 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;118;117;117 15:25:50 INFO - PROCESS | 761 | |6;imaging-darkroom;148;147;146;147;147;147;146;147;147;147 15:25:50 INFO - PROCESS | 761 | |7;imaging-desaturate;95;95;96;96;96;96;96;96;96;95 15:25:50 INFO - PROCESS | 761 | |8;json-parse-financial;66;67;67;65;66;67;67;78;64;64 15:25:50 INFO - PROCESS | 761 | |9;json-stringify-tinderbox;63;64;63;65;65;64;64;64;65;64 15:25:50 INFO - PROCESS | 761 | |10;stanford-crypto-aes;80;81;82;82;90;82;83;82;82;82 15:25:50 INFO - PROCESS | 761 | |11;stanford-crypto-ccm;121;120;119;131;117;116;119;114;123;124 15:25:50 INFO - PROCESS | 761 | |12;stanford-crypto-pbkdf2;142;141;141;140;148;142;140;130;140;139 15:25:50 INFO - PROCESS | 761 | |13;stanford-crypto-sha256-iterative;68;67;68;65;65;69;65;68;65;65 15:25:50 INFO - PROCESS | 761 | __end_tp_report 15:25:50 INFO - PROCESS | 761 | __start_cc_report 15:25:50 INFO - PROCESS | 761 | _x_x_mozilla_cycle_collect,1149 15:25:50 INFO - PROCESS | 761 | __end_cc_report 15:25:50 INFO - PROCESS | 761 | __startTimestamp1458339950302__endTimestamp 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | ------- Summary: start ------- 15:25:50 INFO - PROCESS | 761 | Number of tests: 14 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.86 (3.5%) stddev-sans-first:4.09 15:25:50 INFO - PROCESS | 761 | Values: 110.0 112.0 108.0 112.0 114.0 112.0 100.0 110.0 111.0 111.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:155.50 stddev:20.33 (13.1%) stddev-sans-first:21.56 15:25:50 INFO - PROCESS | 761 | Values: 154.0 138.0 156.0 175.0 131.0 166.0 155.0 133.0 190.0 129.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.50 stddev:1.57 (1.0%) stddev-sans-first:1.64 15:25:50 INFO - PROCESS | 761 | Values: 161.0 164.0 161.0 163.0 160.0 159.0 163.0 161.0 163.0 162.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#3] audio-fft Cycles:10 Average:84.60 Median:73.50 stddev:16.04 (21.8%) stddev-sans-first:16.54 15:25:50 INFO - PROCESS | 761 | Values: 74.0 74.0 110.0 93.0 73.0 73.0 73.0 113.0 90.0 73.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:93.50 stddev:19.92 (21.3%) stddev-sans-first:20.58 15:25:50 INFO - PROCESS | 761 | Values: 93.0 93.0 135.0 94.0 94.0 93.0 138.0 94.0 94.0 131.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:25:50 INFO - PROCESS | 761 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 15:25:50 INFO - PROCESS | 761 | Values: 148.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:25:50 INFO - PROCESS | 761 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:67.00 stddev:4.01 (6.0%) stddev-sans-first:4.24 15:25:50 INFO - PROCESS | 761 | Values: 66.0 67.0 67.0 65.0 66.0 67.0 67.0 78.0 64.0 64.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 15:25:50 INFO - PROCESS | 761 | Values: 63.0 64.0 63.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:2.72 (3.3%) stddev-sans-first:2.71 15:25:50 INFO - PROCESS | 761 | Values: 80.0 81.0 82.0 82.0 90.0 82.0 83.0 82.0 82.0 82.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:120.50 stddev:4.81 (4.0%) stddev-sans-first:5.10 15:25:50 INFO - PROCESS | 761 | Values: 121.0 120.0 119.0 131.0 117.0 116.0 119.0 114.0 123.0 124.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:141.00 stddev:4.40 (3.1%) stddev-sans-first:4.62 15:25:50 INFO - PROCESS | 761 | Values: 142.0 141.0 141.0 140.0 148.0 142.0 140.0 130.0 140.0 139.0 15:25:50 INFO - PROCESS | 761 | 15:25:50 INFO - PROCESS | 761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.50 stddev:1.65 (2.4%) stddev-sans-first:1.66 15:25:50 INFO - PROCESS | 761 | Values: 68.0 67.0 68.0 65.0 65.0 69.0 65.0 68.0 65.0 65.0 15:25:50 INFO - PROCESS | 761 | -------- Summary: end -------- 15:25:50 INFO - PROCESS | 761 | 15:25:51 INFO - TEST-INFO | 761: exit 0 15:25:51 INFO - TEST-OK | kraken | took 61734ms 15:25:51 INFO - SUITE-END | took 1178s 15:25:51 INFO - Completed test suite (00:19:39) 15:25:51 INFO - javascript benchmark 15:25:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2604.804639652026, 2682.114902082313, 2688.032308368988, 2699.716529764376, 2720.347116691994, 4651.2092944199485, 4687.132880417125, 4724.716517008982, 4747.643926705494, 4751.121042607111, 4727.338172655831, 4750.334953106568, 4757.762111894409, 4764.547368000043, 4774.0, 4276.828926842923, 4368.257396242639, 4378.934315985262, 4424.955750442503, 4435.933460998088, 4231.830726770925, 4334.0681753423005, 4402.075564131536, 4410.316400957857, 4411.5808998145285, 4323.524412314659, 4347.630451411634, 4382.991911860258, 4412.139632771611, 4436.9556304436865, 4338.913221735547, 4349.7825108744755, 4357.498887627931, 4385.035292235703, 4401.625861801751, 4240.1307731914885, 4338.479382474124, 4340.175366680352, 4344.522102568715, 4393.340998850166, 4587.174308624446, 4597.494275629678, 4612.769361531943, 4613.331066995267, 4636.235021221494, 5064.215046667772, 5136.9743151284, 5174.715390653512, 5188.558972487343, 5194.974025129888, 5180.041692286902, 5193.714345710984, 5194.168932970744, 5194.896102077937, 5196.714180720059, 4634.58288754007, 4840.806367745321, 4842.467328593852, 4844.103840789465, 4887.242477416006, 5309.681419114865, 5343.70609616467, 5390.4879036491475, 5404.0, 5414.91877621836, 5041.344625198774, 5051.0, 5052.989402119517, 5071.011152825164, 5114.769835357343, 4999.075171093359, 5131.281620573122, 5142.202958541432, 5143.27994080829, 5148.0, 5046.7476626168545, 5090.08378491875, 5107.259447380109, 5127.820526281562, 5170.121079416508, 5050.772715227824, 5073.568746656576, 5104.157813960729, 5113.0, 5130.486951304914, 4314.8489802857375, 4396.0, 4402.075564131568, 4430.291153415438, 4467.597916187494, 3808.352580061396, 3810.7523011004196, 3817.980910095487, 3874.9225015499533, 3925.1364699766004, 4344.152890186383, 4347.956520434818, 4353.129374125125, 4360.825566977349, 4387.5393083726385, 5043.621728370387, 5081.2378143278065, 5090.898182036412, 5092.541671249605, 5098.796048158032, 4407.691461597721, 4426.911461770746, 4440.511543730187, 4476.932846007313, 4480.462344518679, 4639.280911458729, 4678.976605117021, 4684.414448193976, 4685.367475390847, 4728.361671174416, 4755.072760811747, 4846.975765121152, 4856.320115183948, 4860.538248866352, 4863.3434486343895, 5121.539061484485, 5139.717315547681, 5143.974280128576, 5168.0, 5199.064168449715, 4831.685940413862, 4841.346418233494, 4842.201036828884, 4842.201036828884, 4890.926636100533, 4951.900961980668, 5026.47222041695, 5055.6713813602, 5099.490050995019, 5100.362454693163, 5138.948610513997, 5144.588432925432, 5157.690538567698, 5166.070107380708, 5182.663126896739, 4996.425411077627, 5005.449400566008, 5013.874653133701, 5016.2224855147515, 5058.671186372874, 4878.341423907727, 4950.975245123751, 4998.475160108282, 5004.524570165829, 5032.3961124665275, 4924.50754924519, 4933.481984391731, 4947.208446648519, 4960.280759289811, 4988.401391832858, 5013.24801279811, 5033.144365457954, 5035.345405097314, 5036.521530454601, 5086.3896332440345, 4879.121758083579, 4906.656534042726, 4921.753912304442, 4985.052839960396, 4997.925031124463], "unit": "score", "name": "dojo.html", "value": 4702.767038186836}, {"lowerIsBetter": false, "replicates": [546.2025442853434, 560.1429812387048, 564.9773909224307, 577.7457918515853, 581.4476247564813, 27246.86376568117, 27670.584941225872, 27704.445911081766, 27707.168784936435, 27764.444711105767, 28005.439891202215, 35124.2975140497, 35701.0, 35738.0, 35806.462903056476, 7704.614769261529, 7870.685172593089, 7876.054873415198, 7877.0, 7880.842383152333, 7676.270754278335, 7789.844203115934, 7793.181715919832, 7796.688132474695, 7797.33722633574, 7762.262585054411, 7827.0607527096545, 7840.098388685288, 7847.372210223169, 8021.358291336708, 7866.960665196694, 7912.683492660315, 7960.761177164694, 7967.920320796776, 7968.0, 7811.648475818602, 7924.286814186751, 7943.046834379854, 7945.165757595485, 7946.602669866484, 38165.0, 38596.421053684215, 38660.0, 38684.032899177466, 38685.61314386848, 3232.2242661761243, 3342.8161451120177, 3362.4451965425674, 3810.12367155553, 3855.20968201518, 25736.87131564349, 26225.344366390804, 26496.367143385494, 26609.73390266092, 28585.99796028558, 3417.2994536120036, 3419.692227699519, 3437.2094418283687, 3460.1176699941607, 3543.7696549724187, 250254.0, 251437.0, 251927.0, 252398.0, 254183.0, 51488.48511514837, 52264.21603675948, 52300.47699522956, 52338.95322093537, 52378.47621523736, 62428.68785656043, 62905.37094629087, 63249.36750632527, 63365.36634633595, 63415.365846340945, 12445.937770311271, 12466.87533124657, 12471.438785254686, 12526.311052892179, 12563.18339307942, 10372.481375931324, 10428.843567346496, 10436.165106791439, 10438.0, 10439.530221140067, 19186.328478503186, 19278.807211927702, 19339.51651208703, 19342.709859352122, 19958.20167193296, 7757.806054848674, 7851.882221766678, 7960.761177164694, 8027.317677997319, 8042.919570804334, 871.4814685262259, 879.8636211387245, 897.3673560140086, 913.141646851957, 986.7582442301539, 25799.226023219333, 26960.191194264204, 27151.0, 27496.862515687695, 27677.0, 987.5654711926729, 994.1500017485091, 1005.0000249751544, 1007.2797949466167, 1041.401194313273, 14107.858921410654, 14268.143911365143, 14473.421063157355, 14544.563663090124, 14548.563543093724, 282147.0, 285116.0, 285136.0, 285343.0, 286861.0, 46221.0, 46232.3065154023, 46372.0, 46484.302735458994, 46564.7671761639, 1154.7459558897028, 1179.8761130081389, 1212.8120141378101, 1242.2049888071642, 1277.0294576122214, 27965.16104516868, 29137.271568210963, 29943.0, 30205.69794302029, 30354.0, 40604.0, 41127.794361028005, 41252.1749565001, 41275.0, 41293.38059929164, 255147.0, 258429.0, 259054.0, 259834.0, 260886.0, 31986.68013319837, 32020.19949501281, 32636.510452342758, 32721.34557308793, 32727.509087364186, 39575.80212098921, 39641.40537891876, 40314.395284070175, 40405.0, 40848.59151408448, 35157.47263791096, 39670.80164599274, 40939.0, 41100.79449602733, 41707.7914610425, 36511.81744091262, 36828.447573285885, 37099.62900370962, 37199.81400092982, 37351.81324093471, 28507.572386413805, 36610.63389366072, 37265.25469490649, 37745.81127094347, 37828.81085594664, 28285.57571636386, 30011.69988300089, 31200.843995779876, 31933.0, 32147.463778984762, 24808.759562021467, 24911.252662420156, 24976.50046999086, 25087.372815679024, 25344.493110138064], "unit": "score", "name": "ext.html", "value": 17220.98777746376}, {"lowerIsBetter": false, "replicates": [347.189312954252, 354.60461585332354, 363.9308531379038, 364.2278369855906, 369.3425702249996, 16490.91754541227, 16973.405930792425, 17091.743623845636, 17422.0, 17435.3025878965, 16533.421330253444, 16702.66594668106, 17209.741853872172, 17215.82784172158, 17233.396831110913, 4494.842680506166, 4912.214045752689, 5055.115354812911, 5059.620528460362, 5061.569766569827, 4960.635825148077, 4980.377452818398, 4987.875303117433, 4996.400431948171, 5013.4234563025175, 4955.801767929279, 4963.305137280783, 4969.8012079516775, 4970.428400733907, 5199.922001169985, 5168.9224661630105, 5171.534561889429, 5172.560332371753, 5190.6107041972, 5206.167013277895, 4967.081089998325, 4969.329140566014, 5011.1481048221885, 5016.372953380827, 5017.573506251973, 11636.941815290955, 11774.529018839321, 11926.701832454171, 11947.641570752892, 11953.701157471045, 1852.9814701852945, 1897.667908116088, 1977.5253939054667, 2002.2491565662876, 2014.0817136057092, 9200.263978881674, 9486.810263794754, 10238.846417303746, 10679.786404271948, 12840.486380544768, 1799.5321216483678, 1801.4955812372557, 1845.2065611786927, 1851.7685289338833, 1883.1243471785685, 53481.46518534804, 55464.44535554673, 57577.0, 60320.698396508174, 63163.36836631621, 10187.490625468698, 10458.738531536772, 10484.213683973732, 10601.946990265, 10621.362718236931, 13281.402336894864, 13366.796988271102, 13399.263040532669, 13421.66445838862, 13423.932880335537, 6930.3762661360715, 7020.403265722471, 7045.084139061992, 7100.289971002859, 7110.0, 6461.515386346043, 6565.737370505126, 6590.209174899042, 6611.33886611335, 6657.0, 4385.693001489865, 4499.6400287976885, 4504.864854054384, 4545.0, 4552.931706024412, 1780.8397244247822, 1790.8656850736247, 1808.3670715249557, 1810.08590661715, 1824.224704500582, 735.7351353512731, 858.802475430642, 870.3950754225752, 874.9431286966327, 926.1988380051207, 15917.602059948595, 16090.0, 16177.4337898173, 16411.671766564603, 16722.58193545171, 882.3514716683233, 887.973360799177, 891.5943245823134, 893.0890491698431, 935.5930170375908, 9200.0, 9595.520223988773, 9607.231421486264, 9667.70996870095, 9767.560459779326, 372072.0, 389959.0, 392063.0, 399535.0, 403802.0, 68269.65865170643, 69003.65498172477, 70087.0, 70117.64941175363, 70296.0, 907.4237858959608, 920.7099763574453, 956.2445667922264, 990.1187942730975, 992.2359782967075, 15015.324310406277, 15133.0, 15149.318280677617, 15200.771988419961, 15283.847161528241, 32096.518552221267, 33268.1682957928, 33586.32827343391, 33867.459940504064, 34149.0, 43904.56095439132, 47079.52920470889, 47108.52891471041, 47232.05535889332, 47565.0, 7338.6697598607125, 7455.813604659927, 7495.7001719930595, 7545.7358992435, 7629.961850190713, 8589.65641374338, 11253.49359278818, 11422.885771142515, 11485.196036277715, 11552.191346605658, 9815.607375705178, 9987.350822196535, 10155.54300056514, 10190.949045254727, 10390.480475976323, 9669.951650241705, 9721.4653194075, 9785.0, 9885.456299903575, 9995.750106247402, 9830.361026533252, 10085.798284034132, 10109.443980581138, 10294.742631434274, 10344.32761870476, 7438.0, 7477.327040566375, 7508.136564295176, 7571.583562904093, 7578.886316705364, 10105.444200568745, 10147.949260253652, 10390.948045259725, 10422.583096676048, 10451.895481045092], "unit": "score", "name": "jquery.html", "value": 7903.402586662329}, {"lowerIsBetter": false, "replicates": [1255.6923553729337, 1432.6275168456204, 1433.8422773494913, 1583.2400447785062, 1786.1962117047333, 7314.08573928259, 7470.850582988337, 7471.028766260392, 7484.4012479001685, 7496.287852653996, 7304.196538380774, 7488.0, 7490.625468726569, 7493.625318734069, 7497.437692173082, 1943.416974907522, 1985.583027564206, 2136.4979229880964, 2207.5915955548194, 2238.21662418154, 2227.5544891021777, 2234.642457206847, 2237.552489502098, 2239.1267405711706, 2240.9887950560224, 2186.9015894284717, 2211.159759291467, 2218.434299253688, 2227.866328020316, 2239.7984181423667, 2147.7744836792226, 2154.407537927075, 2154.838387120972, 2159.762426133124, 2161.492049368397, 2190.8028277455105, 2204.603171429142, 2208.6576580629867, 2210.5910406574676, 2213.435573928638, 7629.923700762977, 7648.617569121521, 7652.1582625911105, 7674.769756907302, 7681.615919204018, 4623.12160689468, 4771.23660214364, 4775.546323099335, 4787.40157480315, 4789.185838407444, 3029.3486900316316, 3058.266016156129, 3195.984020079908, 3217.501287300472, 3225.645179030305, 961.4423634292094, 968.9224862011022, 971.2375785008734, 972.5137431284357, 997.9800403991879, 10685.519151638116, 10695.144388448905, 10710.46447677613, 10722.839157412645, 10734.409607471585, 4232.343986682069, 4328.675349348811, 4340.52254252032, 4421.823127074946, 4424.424824772759, 9222.44665320083, 9246.167844893856, 9258.768530786785, 9267.073292670679, 9268.165865072177, 4696.483386827446, 4697.906041879143, 4710.128626204163, 4720.811167553328, 4725.054989002213, 3635.1457407509215, 3718.1076541629814, 4181.289180839264, 4216.515100763451, 4250.404943307939, 3652.251288485854, 3722.032271609401, 3723.7951912645067, 3766.472693822867, 3771.8868433947027, 1174.1194104421684, 1182.7344741127083, 1183.5029287699188, 1187.1630500497129, 1205.9276443413423, 1201.801702719059, 1203.8555373355077, 1206.90344772418, 1217.4764851114105, 1223.0338032953866, 7237.312455316736, 7335.4131669466315, 7359.448041396917, 7371.3734332582335, 7388.852222955511, 1036.9325993810528, 1046.3094357723867, 1052.9894701052892, 1053.836655318427, 1084.2681190196586, 5639.915401268984, 5671.376148623648, 5732.283464566929, 5739.282589676291, 5745.195672605839, 8942.284617230605, 9050.411723237969, 9219.262459003263, 9280.767980800534, 9360.625574976924, 9278.396904201205, 9416.387934784218, 9495.525223738785, 9503.477308748084, 9538.093881081286, 7156.212816590171, 7276.781696549112, 7412.0364352633815, 7421.888671669929, 7423.85152296951, 6833.69248383814, 6894.724211031703, 6901.344372284826, 6905.309469053054, 6947.201071876799, 8236.217559331853, 8464.238218560113, 8470.915290847013, 8476.618552165044, 8591.140885911358, 8460.534670593177, 8743.081976392386, 8747.03782583928, 8747.65009399617, 8862.246709029547, 6295.716692748746, 6355.872882542416, 6449.3550644937, 6465.64438955862, 6476.579022363531, 7239.963800180965, 7292.197858235484, 7295.890561641473, 7339.816504587428, 7406.629668516445, 6570.375814297634, 6747.696353664195, 6783.219929708147, 6811.250762416031, 6857.417119544894, 6661.1340525733285, 6716.630585317659, 6751.426128779109, 6786.59280443175, 6810.8637827244165, 6957.478189135733, 6959.930400696131, 7009.579425234502, 7079.079719636415, 7079.29207079288, 6206.689665516797, 6219.067139928866, 6267.435930766253, 6278.497720182466, 6279.026750853625, 6513.283538810632, 6583.934160658332, 6595.571287866273, 6596.208454985433, 6597.5381723280825], "unit": "score", "name": "mootools.html", "value": 4422.807105138894}, {"lowerIsBetter": false, "replicates": [321.1905996887843, 321.61406312425095, 324.832711153756, 327.73126036649955, 328.2122905027933, 5330.813421530247, 5413.350397952247, 5422.566194704424, 5433.945660543393, 5441.891162176764, 5334.199870019499, 5357.223202635615, 5366.034113859504, 5370.62405631605, 5381.112116500783, 3919.176972835708, 4056.3104272273786, 4122.670186385082, 4143.378493226025, 4200.432941552889, 4173.332266837307, 4180.644645205161, 4180.979095104535, 4181.310083836179, 4187.225363307783, 4131.917361652765, 4138.565450627686, 4140.358244472111, 4141.213169497786, 4154.376843473473, 3942.0933185367385, 4029.717919745619, 4082.7754473503946, 4088.5093788745244, 4111.0, 3639.0538460000325, 3643.2531331077066, 3643.5627724672945, 3652.3425783358985, 3656.8171591420323, 5132.307138536287, 5143.7685304161405, 5144.717040562805, 5145.382554093533, 5148.330717006803, 4789.664723469358, 4790.041991601694, 4794.448638406593, 4799.616030717534, 4808.0, 5620.606557540974, 5631.2397826293745, 5632.239647647556, 5632.802851900164, 5633.352164501053, 4032.8185231664647, 4033.3143365627916, 4035.7982100894837, 4041.2523683118716, 4046.190761847613, 5685.147227915804, 5940.643561386288, 5972.731227094748, 5977.133315669247, 5979.820605381802, 4019.397090436458, 4062.8171732272117, 4063.1061166543313, 4063.1264278180333, 4066.34938409853, 4115.1975364804175, 4116.732412393185, 4118.217538667644, 4119.299719047769, 4120.711550191518, 4723.858284251478, 4727.2436410174205, 4728.4562275338085, 4730.9763451182525, 4735.431748190239, 5680.602357834994, 5683.147527870852, 5683.175939488751, 5693.857653558694, 5697.202391665171, 1403.4736973634888, 1446.8263808343065, 1448.7102579484144, 1449.644837014938, 1450.804141440892, 882.4969767232744, 934.2525979216599, 943.099340130174, 955.245356168633, 970.4807927758616, 4852.126617208865, 4863.805447782049, 4865.95134048655, 4866.343043689128, 4872.049950259665, 5800.883982320414, 5806.535477161901, 5807.767689292466, 5807.941920580824, 5808.012637851575, 4900.583450406684, 4902.068606964736, 4908.04293162837, 4909.361782968263, 4914.361133052752, 3095.9226019349244, 3114.8909788157757, 3134.639516455591, 3136.702013308732, 3136.7490600751885, 5438.592105592096, 5439.156930675752, 5443.374011988592, 5443.673379597237, 5446.509814116748, 5778.855528611734, 5952.464278214981, 5952.523798096228, 5955.464008239279, 5965.613754498236, 5398.838034858961, 5418.051840927822, 5427.457254274541, 5436.266104075979, 5440.347158341025, 5799.507041901317, 5802.0, 5803.47768700819, 5807.157962095557, 5810.622309549865, 5658.745356459051, 5701.287339082614, 5711.885762284648, 5715.2855893013375, 5731.799387021434, 5437.510624043855, 5450.2369668247275, 5458.317710286215, 5459.099248623933, 5459.372172200089, 3944.092858642471, 4055.8377664893073, 4067.471228740363, 4071.959280407158, 4077.959220407758, 5752.13717942312, 5768.278965129359, 5770.422957704196, 5780.682062486603, 5784.045632470596, 5577.832665020056, 5583.944160558342, 5588.133839254922, 5588.133839254922, 5593.776248949996, 5529.723513824373, 5585.134304182858, 5585.245991791218, 5591.440855914376, 5594.300712410949, 5460.099083651153, 5480.753366098455, 5490.3411590609385, 5492.5605951524585, 5503.091989821634, 5514.862128446821, 5686.0, 5690.829275121753, 5697.4302569742695, 5707.258056452634, 5547.944520554743, 5593.272874526286, 5594.86012849682, 5597.720113994365, 5603.915941260802], "unit": "score", "name": "prototype.html", "value": 4226.095700278575}, {"lowerIsBetter": false, "replicates": [654.7839213059691, 696.696936832478, 702.4520873718499, 746.8991686122375, 761.9999999999998, 11965.461554230058, 12107.636770896865, 12121.33332666703, 12161.51353945841, 12201.572944946929, 11749.588764393247, 11781.29312241266, 11807.291562506256, 11846.466908989094, 11862.288262704244, 642.8296501427126, 778.1790211327047, 780.9140994490616, 800.0839039299998, 803.0644299391203, 802.7110240313483, 803.120582961656, 807.3016840433013, 808.2241048593328, 808.975730728079, 840.5923127283263, 843.4475418600827, 845.9196376344269, 846.2637505370305, 846.3018010141627, 675.223492983071, 840.4117118017413, 848.4866655673352, 849.3120572336427, 850.0564373545391, 616.5838059309948, 617.4473845907887, 617.5769597825459, 618.3877960818756, 619.0899377914459, 12141.514339426412, 12173.2696038238, 12187.32969686667, 12240.387980601023, 12257.080718946025, 12230.816537751942, 12454.128211025232, 12611.306378149198, 12613.684657883534, 12626.494940202381, 9850.852237216448, 9905.653302134462, 10065.295429319951, 10070.848937265946, 10092.747681307952, 3347.8493467794005, 3419.46998215277, 3421.7775844570024, 3465.861365545375, 3470.4273794824076, 43828.99999999968, 43968.56031439709, 44007.339889901676, 44025.0, 44041.559584404065, 9895.0, 9994.0, 10124.088832005154, 10129.290949633454, 10271.537780799881, 17887.0, 17902.731459028124, 17929.19318630665, 17936.282548697905, 17943.102844857705, 6878.415334696507, 6904.516683832084, 7055.6119413431725, 7065.293470652997, 7081.291870812877, 3802.942955855609, 3805.6574908257835, 3807.809609519513, 3826.6364695354455, 3828.349180639298, 2988.701129886994, 3029.3941211757738, 3044.451998640266, 3049.969500305013, 3051.6572708008407, 517.7799435240008, 520.6485622204997, 532.4888107416923, 543.6058857328405, 546.3198318093919, 618.7964409224106, 626.5614070150913, 631.0754744299531, 642.4121928435429, 643.9742410303629, 7872.527648341118, 8281.792955176048, 8292.013082665493, 8347.0, 8490.745277641681, 605.5518916002127, 609.1593600830826, 609.5793902207463, 615.0282553565356, 647.8542327976262, 3728.086618778362, 3763.2849758546336, 3786.280606684721, 3812.4662547243406, 3843.6540711336115, 54658.0, 55766.72116639472, 55858.0, 56149.15776263359, 56373.71813140908, 44255.55744442515, 45361.0, 45477.0, 46317.30524042142, 46404.071918561436, 42199.36700949488, 42447.0, 43159.0, 43212.3518147228, 43269.35095973563, 8039.919600804151, 8123.959380203061, 8230.135835737161, 8243.876341854757, 8402.957985210034, 32396.35207295888, 32469.0, 32903.506447402826, 33020.0, 33647.831760841036, 38008.0, 38082.0, 41824.581754182065, 42907.7854610725, 43536.78231608822, 9996.518971604639, 10127.392356458637, 10366.806255022388, 10389.584416623251, 10491.632792852213, 11541.307521548733, 11583.131265155316, 11755.588554400554, 12069.094817888517, 12194.57318993831, 9591.472469013992, 9652.083052110038, 9718.659846905324, 9765.560549775135, 10060.84908726355, 10544.0, 10793.67618971432, 10951.123910087015, 10967.232293739362, 11184.0, 10103.898961010296, 10238.846417303896, 10432.582696692047, 10483.21375896826, 10557.260991730505, 8329.541875196923, 8723.302135829246, 8855.512946787989, 9095.0, 9190.49452280131, 8721.215090641872, 8760.91239087601, 8875.514855840374, 9362.531873406439, 9867.506624668882], "unit": "score", "name": "yui.html", "value": 5948.750252728163}], "name": "dromaeo_css", "value": 6437.5665425806565}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 108.0, 112.0, 114.0, 112.0, 100.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [154.0, 138.0, 156.0, 175.0, 131.0, 166.0, 155.0, 133.0, 190.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 152.7}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 161.0, 163.0, 160.0, 159.0, 163.0, 161.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 110.0, 93.0, 73.0, 73.0, 73.0, 113.0, 90.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 135.0, 94.0, 94.0, 93.0, 138.0, 94.0, 94.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 65.0, 66.0, 67.0, 67.0, 78.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 67.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 82.0, 90.0, 82.0, 83.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 119.0, 131.0, 117.0, 116.0, 119.0, 114.0, 123.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 141.0, 140.0, 148.0, 142.0, 140.0, 130.0, 140.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 65.0, 65.0, 69.0, 65.0, 68.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1515.3999999999999}]} 15:25:51 INFO - Return code: 0 15:25:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:25:51 ERROR - # TBPL SUCCESS # 15:25:51 INFO - Running post-action listener: _resource_record_post_action 15:25:51 INFO - Running post-run listener: _resource_record_post_run 15:25:52 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 519933952; Read time: 24; Write time: 402364 15:25:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238616576; Read time: 0; Write time: 228608 15:25:52 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 281116672; Read time: 24; Write time: 173736 15:25:52 INFO - Running post-run listener: _upload_blobber_files 15:25:52 INFO - Blob upload gear active. 15:25:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:25:52 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 15:25:52 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'] 15:25:52 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 15:25:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:54 INFO - (blobuploader) - INFO - Done attempting. 15:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:25:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:54 INFO - (blobuploader) - INFO - Done attempting. 15:25:54 INFO - (blobuploader) - INFO - Iteration through files over. 15:25:54 INFO - Return code: 0 15:25:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:25:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:25:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8311f0b80389fceb040d2ad1736fdac54764ea5dac6ff892678f8904fc46b03b6bc052cb602dcf1ea611844b2d1e27b750216bec0e6d8b2a3a8df2f806ad6f8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3e03ab6ca7102bacee403d2484ec7e2f9baa1248c5743d94ab5f2b3bbb2d73db9737e154dc7bee702fd7f7f160aaf1cbf9868e5c1e06f066d837881d778941c"} 15:25:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:25:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:25:54 INFO - Contents: 15:25:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8311f0b80389fceb040d2ad1736fdac54764ea5dac6ff892678f8904fc46b03b6bc052cb602dcf1ea611844b2d1e27b750216bec0e6d8b2a3a8df2f806ad6f8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3e03ab6ca7102bacee403d2484ec7e2f9baa1248c5743d94ab5f2b3bbb2d73db9737e154dc7bee702fd7f7f160aaf1cbf9868e5c1e06f066d837881d778941c"} 15:25:54 INFO - Running post-run listener: copy_logs_to_upload_dir 15:25:54 INFO - Copying logs to upload dir... 15:25:54 INFO - mkdir: /builds/slave/test/build/upload/logs 15:25:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.899534 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-03-18 15:25:54.884277) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 15:25:54.888040) ========= 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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 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/8311f0b80389fceb040d2ad1736fdac54764ea5dac6ff892678f8904fc46b03b6bc052cb602dcf1ea611844b2d1e27b750216bec0e6d8b2a3a8df2f806ad6f8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3e03ab6ca7102bacee403d2484ec7e2f9baa1248c5743d94ab5f2b3bbb2d73db9737e154dc7bee702fd7f7f160aaf1cbf9868e5c1e06f066d837881d778941c"} build_url:https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/LST8nzsdSzWojQ6GS788Dw/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/8311f0b80389fceb040d2ad1736fdac54764ea5dac6ff892678f8904fc46b03b6bc052cb602dcf1ea611844b2d1e27b750216bec0e6d8b2a3a8df2f806ad6f8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e3e03ab6ca7102bacee403d2484ec7e2f9baa1248c5743d94ab5f2b3bbb2d73db9737e154dc7bee702fd7f7f160aaf1cbf9868e5c1e06f066d837881d778941c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 15:25:54.912396) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:25:54.912712) ========= 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=00204705a9daa57ed339a427000001b9-1458338709.322433-1256464886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:25:54.995316) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 15:25:54.995620) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 15:25:54.995919) ========= ========= Total master_lag: 0.33 =========