builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1457489404.37 results: success (0) buildid: 20160308171512 builduid: 4edbd102844244558a186232ec92a954 revision: a5c5f12698e05859a4ceac9163ee7aef9191c749 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.369560) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.370090) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.370446) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006479 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.396078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.396441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.471112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.471418) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.528384) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.528733) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.529399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.529716) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-08 18:10:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.3M=0s 2016-03-08 18:10:05 (30.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086167 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.655884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.656212) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022319 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.709943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:04.710329) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5c5f12698e05859a4ceac9163ee7aef9191c749 --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 a5c5f12698e05859a4ceac9163ee7aef9191c749 --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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-08 18:10:05,328 truncating revision to first 12 chars 2016-03-08 18:10:05,328 Setting DEBUG logging. 2016-03-08 18:10:05,328 attempt 1/10 2016-03-08 18:10:05,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5c5f12698e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 18:10:05,568 unpacking tar archive at: fx-team-a5c5f12698e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:05.255654) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:05.256005) ========= echo a5c5f12698e05859a4ceac9163ee7aef9191c749 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a5c5f12698e05859a4ceac9163ee7aef9191c749'] 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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a5c5f12698e05859a4ceac9163ee7aef9191c749 program finished with exit code 0 elapsedTime=0.004663 script_repo_revision: 'a5c5f12698e05859a4ceac9163ee7aef9191c749' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:05.307474) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:05.307828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 18:10:05.318045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-03-08 18:10:05.318483) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:10:06 INFO - MultiFileLogger online at 20160308 18:10:06 in /builds/slave/test 18:10:06 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 18:10:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:10:06 INFO - {'append_to_log': False, 18:10:06 INFO - 'base_work_dir': '/builds/slave/test', 18:10:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:10:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:10:06 INFO - 'branch': 'Fx-Team-Non-PGO', 18:10:06 INFO - 'buildbot_json_path': 'buildprops.json', 18:10:06 INFO - 'config_files': ('talos/linux_config.py',), 18:10:06 INFO - 'default_actions': ('clobber', 18:10:06 INFO - 'read-buildbot-config', 18:10:06 INFO - 'download-and-extract', 18:10:06 INFO - 'populate-webroot', 18:10:06 INFO - 'create-virtualenv', 18:10:06 INFO - 'install', 18:10:06 INFO - 'run-tests'), 18:10:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:10:06 INFO - 'download_minidump_stackwalk': True, 18:10:06 INFO - 'download_symbols': 'ondemand', 18:10:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:10:06 INFO - 'tooltool.py': '/tools/tooltool.py', 18:10:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:10:06 INFO - '/tools/misc-python/virtualenv.py')}, 18:10:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:10:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:10:06 INFO - 'installer_path': 'installer.exe', 18:10:06 INFO - 'log_level': 'info', 18:10:06 INFO - 'log_name': 'talos', 18:10:06 INFO - 'log_to_console': True, 18:10:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:10:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:10:06 INFO - 'opt_config_files': (), 18:10:06 INFO - 'pip_index': False, 18:10:06 INFO - 'sps_profile': False, 18:10:06 INFO - 'sps_profile_interval': 0, 18:10:06 INFO - 'suite': 'dromaeojs', 18:10:06 INFO - 'system_bits': '32', 18:10:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:10:06 INFO - 'title': 'talos-linux64-ix-042', 18:10:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:10:06 INFO - 'use_talos_json': True, 18:10:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:10:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:10:06 INFO - 'work_dir': 'build'} 18:10:06 INFO - ##### 18:10:06 INFO - ##### Running clobber step. 18:10:06 INFO - ##### 18:10:06 INFO - Running pre-action listener: _resource_record_pre_action 18:10:06 INFO - Running main action method: clobber 18:10:06 INFO - rmtree: /builds/slave/test/build 18:10:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:10:07 INFO - Running post-action listener: _resource_record_post_action 18:10:07 INFO - ##### 18:10:07 INFO - ##### Running read-buildbot-config step. 18:10:07 INFO - ##### 18:10:07 INFO - Running pre-action listener: _resource_record_pre_action 18:10:07 INFO - Running main action method: read_buildbot_config 18:10:07 INFO - Using buildbot properties: 18:10:07 INFO - { 18:10:07 INFO - "project": "", 18:10:07 INFO - "product": "firefox", 18:10:07 INFO - "script_repo_revision": "production", 18:10:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:10:07 INFO - "repository": "", 18:10:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:10:07 INFO - "buildid": "20160308171512", 18:10:07 INFO - "pgo_build": "False", 18:10:07 INFO - "basedir": "/builds/slave/test", 18:10:07 INFO - "buildnumber": 1530, 18:10:07 INFO - "slavename": "talos-linux64-ix-042", 18:10:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:10:07 INFO - "platform": "ubuntu64_hw", 18:10:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:10:07 INFO - "branch": "fx-team", 18:10:07 INFO - "repo_path": "integration/fx-team", 18:10:07 INFO - "revision": "a5c5f12698e05859a4ceac9163ee7aef9191c749", 18:10:07 INFO - "stage_platform": "linux64", 18:10:07 INFO - "builduid": "4edbd102844244558a186232ec92a954", 18:10:07 INFO - "slavebuilddir": "test" 18:10:07 INFO - } 18:10:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:10:07 INFO - Running post-action listener: _resource_record_post_action 18:10:07 INFO - ##### 18:10:07 INFO - ##### Running download-and-extract step. 18:10:07 INFO - ##### 18:10:07 INFO - Running pre-action listener: _resource_record_pre_action 18:10:07 INFO - Running main action method: download_and_extract 18:10:07 INFO - mkdir: /builds/slave/test/build/tests 18:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:07 INFO - https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:10:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:10:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:10:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:09 INFO - Downloaded 1361 bytes. 18:10:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:10:09 INFO - Using the following test package requirements: 18:10:09 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:10:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:10:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:10:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:09 INFO - u'jsshell-linux-x86_64.zip'], 18:10:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:10:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:10:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:10:09 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:10:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:10:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:10:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:09 INFO - https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:10 INFO - Downloaded 22092924 bytes. 18:10:10 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'] 18:10:10 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 18:10:12 INFO - Return code: 0 18:10:12 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 18:10: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')]} 18:10:12 INFO - https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:10:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:10:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:10:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:13 INFO - Downloaded 22092924 bytes. 18:10:13 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'] 18:10:13 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 18:10:14 INFO - Return code: 0 18:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:14 INFO - https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:15 INFO - Downloaded 10845161 bytes. 18:10:15 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'] 18:10:15 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 18:10:16 INFO - Return code: 0 18:10:16 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')]} 18:10:16 INFO - https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:10:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:10:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:10:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6neG80MQ2-telvK4cxsaQ/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 18:10:20 INFO - Downloaded 54321156 bytes. 18:10:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:10:20 INFO - mkdir: /builds/slave/test/properties 18:10:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:10:20 INFO - Writing to file /builds/slave/test/properties/build_url 18:10:20 INFO - Contents: 18:10:20 INFO - build_url:https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:10:21 INFO - Running post-action listener: _resource_record_post_action 18:10:21 INFO - Running post-action listener: set_extra_try_arguments 18:10:21 INFO - ##### 18:10:21 INFO - ##### Running populate-webroot step. 18:10:21 INFO - ##### 18:10:21 INFO - Running pre-action listener: _resource_record_pre_action 18:10:21 INFO - Running main action method: populate_webroot 18:10:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:10:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:10:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:10:21 INFO - '--tppagecycles', 18:10:21 INFO - '7'], 18:10:21 INFO - 'tests': ['tsvgm']}}, 18:10:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:10:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:10:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:10:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:10:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:21 INFO - 'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:21 INFO - 'tests': ['damp', 'tps']}, 18:10:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:21 INFO - 'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['damp', 'tps']}, 18:10:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:10:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:10:21 INFO - 'other': {'tests': ['a11yr', 18:10:21 INFO - 'ts_paint', 18:10:21 INFO - 'tpaint', 18:10:21 INFO - 'sessionrestore', 18:10:21 INFO - 'sessionrestore_no_auto_restore', 18:10:21 INFO - 'tabpaint']}, 18:10:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['a11yr', 18:10:21 INFO - 'ts_paint', 18:10:21 INFO - 'tpaint', 18:10:21 INFO - 'sessionrestore', 18:10:21 INFO - 'sessionrestore_no_auto_restore', 18:10:21 INFO - 'tabpaint']}, 18:10:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['a11yr', 18:10:21 INFO - 'ts_paint', 18:10:21 INFO - 'tpaint', 18:10:21 INFO - 'sessionrestore', 18:10:21 INFO - 'sessionrestore_no_auto_restore', 18:10:21 INFO - 'tabpaint']}, 18:10:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['a11yr', 18:10:21 INFO - 'ts_paint', 18:10:21 INFO - 'tpaint', 18:10:21 INFO - 'sessionrestore', 18:10:21 INFO - 'sessionrestore_no_auto_restore', 18:10:21 INFO - 'tabpaint']}, 18:10:21 INFO - 'other_l64': {'tests': ['a11yr', 18:10:21 INFO - 'ts_paint', 18:10:21 INFO - 'tpaint', 18:10:21 INFO - 'sessionrestore', 18:10:21 INFO - 'sessionrestore_no_auto_restore', 18:10:21 INFO - 'tabpaint']}, 18:10:21 INFO - 'other_nol64': {'tests': ['a11yr', 18:10:21 INFO - 'ts_paint', 18:10:21 INFO - 'tpaint', 18:10:21 INFO - 'sessionrestore', 18:10:21 INFO - 'sessionrestore_no_auto_restore', 18:10:21 INFO - 'tabpaint']}, 18:10:21 INFO - 'svgr': {'tests': ['tsvgx', 18:10:21 INFO - 'tsvgr_opacity', 18:10:21 INFO - 'tart', 18:10:21 INFO - 'tscrollx', 18:10:21 INFO - 'cart']}, 18:10:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['tsvgx', 18:10:21 INFO - 'tsvgr_opacity', 18:10:21 INFO - 'tart', 18:10:21 INFO - 'tscrollx', 18:10:21 INFO - 'cart']}, 18:10:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:21 INFO - 'tests': ['tp5o']}, 18:10:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:21 INFO - 'talos_options': ['--e10s'], 18:10:21 INFO - 'tests': ['tp5o']}, 18:10:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:21 INFO - 'talos_options': ['--xperf_path', 18:10:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:21 INFO - 'tests': ['tp5n']}, 18:10:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:21 INFO - 'talos_options': ['--e10s', 18:10:21 INFO - '--xperf_path', 18:10:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:21 INFO - 'tests': ['tp5n']}}, 18:10:21 INFO - 'talos.zip': {'path': '', 18:10:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:10:21 INFO - Running post-action listener: _resource_record_post_action 18:10:21 INFO - ##### 18:10:21 INFO - ##### Running create-virtualenv step. 18:10:21 INFO - ##### 18:10:21 INFO - Running pre-action listener: _resource_record_pre_action 18:10:21 INFO - Running main action method: create_virtualenv 18:10:21 INFO - Creating virtualenv /builds/slave/test/build/venv 18:10:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:10:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:10:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:10:21 INFO - Using real prefix '/usr' 18:10:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:10:22 INFO - Installing distribute.............................................................................................................................................................................................done. 18:10:24 INFO - Installing pip.................done. 18:10:24 INFO - Return code: 0 18:10:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:10:24 INFO - Using env: {'DISPLAY': ':0', 18:10:24 INFO - 'HOME': '/home/cltbld', 18:10:24 INFO - 'LANG': 'en_US.UTF-8', 18:10:24 INFO - 'LANGUAGE': 'en_US:en', 18:10:24 INFO - 'LOGNAME': 'cltbld', 18:10:24 INFO - 'MAIL': '/var/mail/cltbld', 18:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:24 INFO - 'MOZ_NO_REMOTE': '1', 18:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:24 INFO - 'NO_EM_RESTART': '1', 18:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:24 INFO - 'PWD': '/builds/slave/test', 18:10:24 INFO - 'SHELL': '/bin/bash', 18:10:24 INFO - 'SHLVL': '1', 18:10:24 INFO - 'TERM': 'linux', 18:10:24 INFO - 'TMOUT': '86400', 18:10:24 INFO - 'USER': 'cltbld', 18:10:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:24 INFO - '_': '/tools/buildbot/bin/python'} 18:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:10:24 INFO - Cleaning up... 18:10:24 INFO - Return code: 0 18:10:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:10:24 INFO - Using env: {'DISPLAY': ':0', 18:10:24 INFO - 'HOME': '/home/cltbld', 18:10:24 INFO - 'LANG': 'en_US.UTF-8', 18:10:24 INFO - 'LANGUAGE': 'en_US:en', 18:10:24 INFO - 'LOGNAME': 'cltbld', 18:10:24 INFO - 'MAIL': '/var/mail/cltbld', 18:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:24 INFO - 'MOZ_NO_REMOTE': '1', 18:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:24 INFO - 'NO_EM_RESTART': '1', 18:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:24 INFO - 'PWD': '/builds/slave/test', 18:10:24 INFO - 'SHELL': '/bin/bash', 18:10:24 INFO - 'SHLVL': '1', 18:10:24 INFO - 'TERM': 'linux', 18:10:24 INFO - 'TMOUT': '86400', 18:10:24 INFO - 'USER': 'cltbld', 18:10:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:24 INFO - '_': '/tools/buildbot/bin/python'} 18:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:24 INFO - Downloading/unpacking psutil>=0.7.1 18:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:10:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:26 INFO - Installing collected packages: psutil 18:10:26 INFO - Running setup.py install for psutil 18:10:26 INFO - building 'psutil._psutil_linux' extension 18:10:26 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 18:10:26 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 18:10:26 INFO - building 'psutil._psutil_posix' extension 18:10:26 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 18:10:26 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 18:10:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:26 INFO - Successfully installed psutil 18:10:26 INFO - Cleaning up... 18:10:27 INFO - Return code: 0 18:10:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:10:27 INFO - Using env: {'DISPLAY': ':0', 18:10:27 INFO - 'HOME': '/home/cltbld', 18:10:27 INFO - 'LANG': 'en_US.UTF-8', 18:10:27 INFO - 'LANGUAGE': 'en_US:en', 18:10:27 INFO - 'LOGNAME': 'cltbld', 18:10:27 INFO - 'MAIL': '/var/mail/cltbld', 18:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:27 INFO - 'MOZ_NO_REMOTE': '1', 18:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:27 INFO - 'NO_EM_RESTART': '1', 18:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:27 INFO - 'PWD': '/builds/slave/test', 18:10:27 INFO - 'SHELL': '/bin/bash', 18:10:27 INFO - 'SHLVL': '1', 18:10:27 INFO - 'TERM': 'linux', 18:10:27 INFO - 'TMOUT': '86400', 18:10:27 INFO - 'USER': 'cltbld', 18:10:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:27 INFO - '_': '/tools/buildbot/bin/python'} 18:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:10:29 INFO - Installing collected packages: mozsystemmonitor 18:10:29 INFO - Running setup.py install for mozsystemmonitor 18:10:29 INFO - Successfully installed mozsystemmonitor 18:10:29 INFO - Cleaning up... 18:10:29 INFO - Return code: 0 18:10:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:10:29 INFO - Using env: {'DISPLAY': ':0', 18:10:29 INFO - 'HOME': '/home/cltbld', 18:10:29 INFO - 'LANG': 'en_US.UTF-8', 18:10:29 INFO - 'LANGUAGE': 'en_US:en', 18:10:29 INFO - 'LOGNAME': 'cltbld', 18:10:29 INFO - 'MAIL': '/var/mail/cltbld', 18:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:29 INFO - 'MOZ_NO_REMOTE': '1', 18:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:29 INFO - 'NO_EM_RESTART': '1', 18:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:29 INFO - 'PWD': '/builds/slave/test', 18:10:29 INFO - 'SHELL': '/bin/bash', 18:10:29 INFO - 'SHLVL': '1', 18:10:29 INFO - 'TERM': 'linux', 18:10:29 INFO - 'TMOUT': '86400', 18:10:29 INFO - 'USER': 'cltbld', 18:10:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:29 INFO - '_': '/tools/buildbot/bin/python'} 18:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:29 INFO - Downloading/unpacking blobuploader==1.2.4 18:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:31 INFO - Downloading blobuploader-1.2.4.tar.gz 18:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:10:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:10:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:31 INFO - Downloading docopt-0.6.1.tar.gz 18:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:10:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:10:32 INFO - Running setup.py install for blobuploader 18:10:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:10:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:10:32 INFO - Running setup.py install for requests 18:10:32 INFO - Running setup.py install for docopt 18:10:32 INFO - Successfully installed blobuploader requests docopt 18:10:32 INFO - Cleaning up... 18:10:32 INFO - Return code: 0 18:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:32 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')]} 18:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:32 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')]} 18:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:32 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 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:32 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 18:10:32 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 18:10:32 INFO - Using env: {'DISPLAY': ':0', 18:10:32 INFO - 'HOME': '/home/cltbld', 18:10:32 INFO - 'LANG': 'en_US.UTF-8', 18:10:32 INFO - 'LANGUAGE': 'en_US:en', 18:10:32 INFO - 'LOGNAME': 'cltbld', 18:10:32 INFO - 'MAIL': '/var/mail/cltbld', 18:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:32 INFO - 'MOZ_NO_REMOTE': '1', 18:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:32 INFO - 'NO_EM_RESTART': '1', 18:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:32 INFO - 'PWD': '/builds/slave/test', 18:10:32 INFO - 'SHELL': '/bin/bash', 18:10:32 INFO - 'SHLVL': '1', 18:10:32 INFO - 'TERM': 'linux', 18:10:32 INFO - 'TMOUT': '86400', 18:10:32 INFO - 'USER': 'cltbld', 18:10:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:32 INFO - '_': '/tools/buildbot/bin/python'} 18:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:32 INFO - Running setup.py (path:/tmp/pip-hUatZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:32 INFO - Running setup.py (path:/tmp/pip-qqrddK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:33 INFO - Running setup.py (path:/tmp/pip-ak4KV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:33 INFO - Running setup.py (path:/tmp/pip-FQ6xz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:33 INFO - Running setup.py (path:/tmp/pip-ZG5S53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:33 INFO - Running setup.py (path:/tmp/pip-z66HOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:33 INFO - Running setup.py (path:/tmp/pip-ypuPhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:33 INFO - Running setup.py (path:/tmp/pip-oHhFoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:33 INFO - Running setup.py (path:/tmp/pip-fZbzZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:33 INFO - Running setup.py (path:/tmp/pip-PGzaEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:33 INFO - Running setup.py (path:/tmp/pip-cdEG4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:33 INFO - Running setup.py (path:/tmp/pip-eJSM6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:33 INFO - Running setup.py (path:/tmp/pip-ELc1FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:33 INFO - Running setup.py (path:/tmp/pip-oSQ8K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:33 INFO - Running setup.py (path:/tmp/pip-Oc5FT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:33 INFO - Running setup.py (path:/tmp/pip-GEO8LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:34 INFO - Running setup.py (path:/tmp/pip-lLiK6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:10:34 INFO - Running setup.py install for manifestparser 18:10:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Running setup.py install for mozcrash 18:10:34 INFO - Running setup.py install for mozdebug 18:10:34 INFO - Running setup.py install for mozdevice 18:10:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Running setup.py install for mozfile 18:10:34 INFO - Running setup.py install for mozhttpd 18:10:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Running setup.py install for mozinfo 18:10:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Running setup.py install for mozInstall 18:10:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:10:34 INFO - Running setup.py install for mozleak 18:10:34 INFO - Running setup.py install for mozlog 18:10:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Running setup.py install for moznetwork 18:10:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Running setup.py install for mozprocess 18:10:35 INFO - Running setup.py install for mozprofile 18:10:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Running setup.py install for mozrunner 18:10:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Running setup.py install for mozscreenshot 18:10:35 INFO - Running setup.py install for moztest 18:10:35 INFO - Running setup.py install for mozversion 18:10:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:10:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:10:35 INFO - Cleaning up... 18:10:35 INFO - Return code: 0 18:10:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:35 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 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:35 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 18:10:35 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 18:10:35 INFO - Using env: {'DISPLAY': ':0', 18:10:35 INFO - 'HOME': '/home/cltbld', 18:10:35 INFO - 'LANG': 'en_US.UTF-8', 18:10:35 INFO - 'LANGUAGE': 'en_US:en', 18:10:35 INFO - 'LOGNAME': 'cltbld', 18:10:35 INFO - 'MAIL': '/var/mail/cltbld', 18:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:35 INFO - 'MOZ_NO_REMOTE': '1', 18:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:35 INFO - 'NO_EM_RESTART': '1', 18:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:35 INFO - 'PWD': '/builds/slave/test', 18:10:35 INFO - 'SHELL': '/bin/bash', 18:10:35 INFO - 'SHLVL': '1', 18:10:35 INFO - 'TERM': 'linux', 18:10:35 INFO - 'TMOUT': '86400', 18:10:35 INFO - 'USER': 'cltbld', 18:10:35 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:35 INFO - '_': '/tools/buildbot/bin/python'} 18:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:36 INFO - Running setup.py (path:/tmp/pip-9vkd65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:36 INFO - Running setup.py (path:/tmp/pip-XGDZf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:36 INFO - Running setup.py (path:/tmp/pip-TJM9GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:36 INFO - Running setup.py (path:/tmp/pip-ztQk00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:36 INFO - Running setup.py (path:/tmp/pip-8zKCXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:36 INFO - Running setup.py (path:/tmp/pip-PY78OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:36 INFO - Running setup.py (path:/tmp/pip-COxiUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:36 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)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:36 INFO - Running setup.py (path:/tmp/pip-KQypih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:36 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)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:36 INFO - Running setup.py (path:/tmp/pip-wxXx7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:36 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)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:36 INFO - Running setup.py (path:/tmp/pip-5NfmFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:36 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)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:36 INFO - Running setup.py (path:/tmp/pip-WiAUDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:36 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)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:36 INFO - Running setup.py (path:/tmp/pip-vw5oOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:36 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)) 18:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:36 INFO - Running setup.py (path:/tmp/pip-77bOkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:37 INFO - Running setup.py (path:/tmp/pip-rsjhPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:37 INFO - Running setup.py (path:/tmp/pip-hIewXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:37 INFO - Running setup.py (path:/tmp/pip-_sN9VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:10:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:37 INFO - Running setup.py (path:/tmp/pip-ExgBWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:10:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:39 INFO - Downloading blessings-1.6.tar.gz 18:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:10:39 INFO - Installing collected packages: blessings 18:10:39 INFO - Running setup.py install for blessings 18:10:39 INFO - Successfully installed blessings 18:10:39 INFO - Cleaning up... 18:10:39 INFO - Return code: 0 18:10:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:39 INFO - Reading from file tmpfile_stdout 18:10:39 INFO - Current package versions: 18:10:39 INFO - argparse == 1.2.1 18:10:39 INFO - blessings == 1.6 18:10:39 INFO - blobuploader == 1.2.4 18:10:39 INFO - docopt == 0.6.1 18:10:39 INFO - manifestparser == 1.1 18:10:39 INFO - mozInstall == 1.12 18:10:39 INFO - mozcrash == 0.17 18:10:39 INFO - mozdebug == 0.1 18:10:39 INFO - mozdevice == 0.48 18:10:39 INFO - mozfile == 1.2 18:10:39 INFO - mozhttpd == 0.7 18:10:39 INFO - mozinfo == 0.9 18:10:39 INFO - mozleak == 0.1 18:10:39 INFO - mozlog == 3.1 18:10:39 INFO - moznetwork == 0.27 18:10:39 INFO - mozprocess == 0.22 18:10:39 INFO - mozprofile == 0.28 18:10:39 INFO - mozrunner == 6.11 18:10:39 INFO - mozscreenshot == 0.1 18:10:39 INFO - mozsystemmonitor == 0.0 18:10:39 INFO - moztest == 0.7 18:10:39 INFO - mozversion == 1.4 18:10:39 INFO - psutil == 3.1.1 18:10:39 INFO - requests == 1.2.3 18:10:39 INFO - wsgiref == 0.1.2 18:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:39 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 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:39 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 18:10:39 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 18:10:39 INFO - Using env: {'DISPLAY': ':0', 18:10:39 INFO - 'HOME': '/home/cltbld', 18:10:39 INFO - 'LANG': 'en_US.UTF-8', 18:10:39 INFO - 'LANGUAGE': 'en_US:en', 18:10:39 INFO - 'LOGNAME': 'cltbld', 18:10:39 INFO - 'MAIL': '/var/mail/cltbld', 18:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:39 INFO - 'MOZ_NO_REMOTE': '1', 18:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:39 INFO - 'NO_EM_RESTART': '1', 18:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:39 INFO - 'PWD': '/builds/slave/test', 18:10:39 INFO - 'SHELL': '/bin/bash', 18:10:39 INFO - 'SHLVL': '1', 18:10:39 INFO - 'TERM': 'linux', 18:10:39 INFO - 'TMOUT': '86400', 18:10:39 INFO - 'USER': 'cltbld', 18:10:39 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:39 INFO - '_': '/tools/buildbot/bin/python'} 18:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 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)) 18:10:39 INFO - Cleaning up... 18:10:39 INFO - Return code: 0 18:10:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:39 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 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:39 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 18:10:39 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 18:10:39 INFO - Using env: {'DISPLAY': ':0', 18:10:39 INFO - 'HOME': '/home/cltbld', 18:10:39 INFO - 'LANG': 'en_US.UTF-8', 18:10:39 INFO - 'LANGUAGE': 'en_US:en', 18:10:39 INFO - 'LOGNAME': 'cltbld', 18:10:39 INFO - 'MAIL': '/var/mail/cltbld', 18:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:39 INFO - 'MOZ_NO_REMOTE': '1', 18:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:39 INFO - 'NO_EM_RESTART': '1', 18:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:39 INFO - 'PWD': '/builds/slave/test', 18:10:39 INFO - 'SHELL': '/bin/bash', 18:10:39 INFO - 'SHLVL': '1', 18:10:39 INFO - 'TERM': 'linux', 18:10:39 INFO - 'TMOUT': '86400', 18:10:39 INFO - 'USER': 'cltbld', 18:10:39 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:39 INFO - '_': '/tools/buildbot/bin/python'} 18:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:40 INFO - Downloading/unpacking jsonschema 18:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:10:41 INFO - Downloading/unpacking functools32 (from jsonschema) 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10: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 18:10:42 INFO - Downloading functools32-3.2.3-2.tar.gz 18:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:10:42 INFO - warning: no files found matching '*.txt' 18:10:42 INFO - no previously-included directories found matching 'build' 18:10:42 INFO - no previously-included directories found matching 'dist' 18:10:42 INFO - no previously-included directories found matching '.git*' 18:10:42 INFO - Installing collected packages: jsonschema, functools32 18:10:42 INFO - Running setup.py install for functools32 18:10:42 INFO - warning: no files found matching '*.txt' 18:10:42 INFO - no previously-included directories found matching 'build' 18:10:42 INFO - no previously-included directories found matching 'dist' 18:10:42 INFO - no previously-included directories found matching '.git*' 18:10:42 INFO - Successfully installed jsonschema functools32 18:10:42 INFO - Cleaning up... 18:10:42 INFO - Return code: 0 18:10:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca1bafbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', '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 18:10:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:10:42 INFO - Using env: {'DISPLAY': ':0', 18:10:42 INFO - 'HOME': '/home/cltbld', 18:10:42 INFO - 'LANG': 'en_US.UTF-8', 18:10:42 INFO - 'LANGUAGE': 'en_US:en', 18:10:42 INFO - 'LOGNAME': 'cltbld', 18:10:42 INFO - 'MAIL': '/var/mail/cltbld', 18:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:42 INFO - 'MOZ_NO_REMOTE': '1', 18:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:42 INFO - 'NO_EM_RESTART': '1', 18:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:42 INFO - 'PWD': '/builds/slave/test', 18:10:42 INFO - 'SHELL': '/bin/bash', 18:10:42 INFO - 'SHLVL': '1', 18:10:42 INFO - 'TERM': 'linux', 18:10:42 INFO - 'TMOUT': '86400', 18:10:42 INFO - 'USER': 'cltbld', 18:10:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:42 INFO - '_': '/tools/buildbot/bin/python'} 18:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:42 INFO - Downloading/unpacking flake8 18:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:10:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:10:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:10:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:10:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:10:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:10:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:10:45 INFO - no previously-included directories found matching 'docs/_build' 18:10:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:10:45 INFO - Running setup.py install for pep8 18:10:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:10:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:10:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:10:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:10:45 INFO - no previously-included directories found matching 'docs/_build' 18:10:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:10:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:10:45 INFO - Cleaning up... 18:10:46 INFO - Return code: 0 18:10:46 INFO - Running post-action listener: _resource_record_post_action 18:10:46 INFO - Running post-action listener: _start_resource_monitoring 18:10:47 INFO - Starting resource monitoring. 18:10:47 INFO - ##### 18:10:47 INFO - ##### Running install step. 18:10:47 INFO - ##### 18:10:47 INFO - Running pre-action listener: _resource_record_pre_action 18:10:47 INFO - Running main action method: install 18:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:10:48 INFO - Reading from file tmpfile_stdout 18:10:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:10:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:10:49 INFO - Reading from file tmpfile_stdout 18:10:49 INFO - Output received: 18:10:49 INFO - Usage: mozinstall [options] installer 18:10:49 INFO - Options: 18:10:49 INFO - -h, --help show this help message and exit 18:10:49 INFO - -d DEST, --destination=DEST 18:10:49 INFO - Directory to install application into. [default: 18:10:49 INFO - "/builds/slave/test"] 18:10:49 INFO - --app=APP Application being installed. [default: firefox] 18:10:49 INFO - mkdir: /builds/slave/test/build/application 18:10:49 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'] 18:10:49 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 18:11:05 INFO - Reading from file tmpfile_stdout 18:11:05 INFO - Output received: 18:11:05 INFO - /builds/slave/test/build/application/firefox/firefox 18:11:05 INFO - Running post-action listener: _resource_record_post_action 18:11:05 INFO - ##### 18:11:05 INFO - ##### Running run-tests step. 18:11:05 INFO - ##### 18:11:05 INFO - Running pre-action listener: _resource_record_pre_action 18:11:05 INFO - Running main action method: run_tests 18:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:11:05 INFO - Python 2.7.3 18:11:05 INFO - Return code: 0 18:11:05 INFO - grabbing minidump binary from tooltool 18:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:05 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 0x11b0160>, '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 0x11b1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b14f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:11:05 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 18:11:05 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 18:11:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:11:05 INFO - Return code: 0 18:11:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:11:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:11:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:11:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:11:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:11:06 INFO - Return code: 0 18:11:06 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/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 18:11:06 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/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 18:11:06 INFO - Using env: {'DISPLAY': ':0', 18:11:06 INFO - 'HOME': '/home/cltbld', 18:11:06 INFO - 'LANG': 'en_US.UTF-8', 18:11:06 INFO - 'LANGUAGE': 'en_US:en', 18:11:06 INFO - 'LOGNAME': 'cltbld', 18:11:06 INFO - 'MAIL': '/var/mail/cltbld', 18:11:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:11:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:06 INFO - 'MOZ_NO_REMOTE': '1', 18:11:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:06 INFO - 'NO_EM_RESTART': '1', 18:11:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:06 INFO - 'PWD': '/builds/slave/test', 18:11:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:11:06 INFO - 'SHELL': '/bin/bash', 18:11:06 INFO - 'SHLVL': '1', 18:11:06 INFO - 'TERM': 'linux', 18:11:06 INFO - 'TMOUT': '86400', 18:11:06 INFO - 'USER': 'cltbld', 18:11:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598', 18:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:06 INFO - '_': '/tools/buildbot/bin/python'} 18:11:06 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/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 18:11:06 INFO - mozversion application_buildid: 20160308171512 18:11:06 INFO - mozversion application_changeset: a5c5f12698e05859a4ceac9163ee7aef9191c749 18:11:06 INFO - mozversion application_display_name: Nightly 18:11:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:11:06 INFO - mozversion application_name: Firefox 18:11:06 INFO - mozversion application_remotingname: firefox 18:11:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:11:06 INFO - mozversion application_vendor: Mozilla 18:11:06 INFO - mozversion application_version: 48.0a1 18:11:06 INFO - mozversion platform_buildid: 20160308171512 18:11:06 INFO - mozversion platform_changeset: a5c5f12698e05859a4ceac9163ee7aef9191c749 18:11:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:11:06 INFO - mozversion platform_version: 48.0a1 18:11:06 INFO - using testdate: 1457489466 18:11:06 INFO - actual date: 1457489466 18:11:06 INFO - starting webserver on 'localhost:34528' 18:11:06 INFO - SUITE-START | Running 2 tests 18:11:06 INFO - TEST-START | dromaeo_css 18:11:06 INFO - operating with platform_type : linux_ 18:11:06 INFO - Initialising browser for dromaeo_css test... 18:11:06 INFO - TEST-INFO | started process 1768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjiF_Le/profile http://localhost:34528/getInfo.html) 18:11:11 INFO - PROCESS | 1768 | __metrics Screen width/height:1600/1200 18:11:11 INFO - PROCESS | 1768 | colorDepth:24 18:11:11 INFO - PROCESS | 1768 | Browser inner width/height: 1024/697 18:11:11 INFO - PROCESS | 1768 | __metrics 18:11:12 ERROR - PROCESS | 1768 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:11:12 INFO - PROCESS | 1768 | 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. 18:11:13 INFO - TEST-INFO | 1768: exit 0 18:11:13 INFO - Browser initialized. 18:11:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:11:13 INFO - TEST-INFO | started process 1860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjiF_Le/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:25 INFO - PROCESS | 1860 | RSS: Main: 153481216 18:11:25 INFO - PROCESS | 1860 | 18:12:16 INFO - PROCESS | 1860 | 1457489536335 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] 18:14:27 INFO - PROCESS | 1860 | Cycle 1(1): loaded http://localhost:34528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34528/tests/dromaeo/cssquery-ext.html) 18:14:28 INFO - PROCESS | 1860 | RSS: Main: 244023296 18:14:28 INFO - PROCESS | 1860 | 18:17:31 INFO - PROCESS | 1860 | Cycle 1(1): loaded http://localhost:34528/tests/dromaeo/cssquery-ext.html (next: http://localhost:34528/tests/dromaeo/cssquery-jquery.html) 18:17:31 INFO - PROCESS | 1860 | RSS: Main: 230330368 18:17:31 INFO - PROCESS | 1860 | 18:20:33 INFO - PROCESS | 1860 | Cycle 1(1): loaded http://localhost:34528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34528/tests/dromaeo/cssquery-mootools.html) 18:20:34 INFO - PROCESS | 1860 | RSS: Main: 231014400 18:20:34 INFO - PROCESS | 1860 | 18:23:36 INFO - PROCESS | 1860 | Cycle 1(1): loaded http://localhost:34528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34528/tests/dromaeo/cssquery-prototype.html) 18:23:36 INFO - PROCESS | 1860 | RSS: Main: 217055232 18:23:36 INFO - PROCESS | 1860 | 18:26:39 INFO - PROCESS | 1860 | Cycle 1(1): loaded http://localhost:34528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34528/tests/dromaeo/cssquery-yui.html) 18:26:40 INFO - PROCESS | 1860 | RSS: Main: 196304896 18:26:40 INFO - PROCESS | 1860 | 18:29:42 INFO - PROCESS | 1860 | Cycle 1(1): loaded http://localhost:34528/tests/dromaeo/cssquery-yui.html (next: http://localhost:34528/tests/dromaeo/cssquery-dojo.html) 18:29:43 INFO - PROCESS | 1860 | RSS: Main: 262668288 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - PROCESS | 1860 | __start_tp_report 18:29:43 INFO - PROCESS | 1860 | _x_x_mozilla_page_load 18:29:43 INFO - PROCESS | 1860 | _x_x_mozilla_page_load_details 18:29:43 INFO - PROCESS | 1860 | |i|pagename|runs| 18:29:43 INFO - PROCESS | 1860 | |0;dojo.html;2550.897964081437;2590;2621.1612284069092;2640.4059086705483;2643.1806140096573;4533.682642215046;4535.750533720644;4559.338895860098;4562.863114106578;4635.258358662614;4587.174308624446;4607.124646317197;4609.014998457356;4610.5850473457385;4616.238320677085;4192.434021407102;4264.89337766556;4295.119500502406;4373.890652733691;4378.080603073358;4109.794510274474;4281.100968796556;4336.154449882259;4336.804843782022;4346;4188.225178341986;4229.873103806891;4271.273883439822;4289.4852617685765;4290.914181716379;4223.493180818291;4231.090315582164;4231.386448964914;4266.317389217741;4271.743695378287;4088.34586466164;4220.240356735786;4222.050038741289;4226.682998775073;4250.426192464009;4483.596476317114;4555.612772914306;4586.793594288265;4597.264437689953;4610.9077818443775;4909.2881532177635;4934.284528743348;4935.111679897617;4936.037472692827;4973.850784476472;4833.130036593412;4922.655414121013;4939.753012349404;4957.281194226853;4993.450720420751;4556.589906908394;4571.108633816374;4578.061497393093;4581.496035436099;4611.4005179326805;5016.724080175552;5024.974875125601;5027.145385284511;5031.144705400091;5061.164907790247;4738.47876733559;4782.880427989258;4825.95174048262;4841.95158048415;4890.388701412324;4975;4993.425756038029;4994.950050499521;4995.200767877195;4995.975020124876;4942.110420124341;4946.777395017233;4947;4947.060058588857;4953.157963146202;4728.1962066448095;4799.592034677022;4891.364122664031;4891.584215341664;4942.654014218971;4074.5314288856566;4079.1637714268504;4082.897927551835;4100.5899410058755;4114.506259248909;3595.82020898954;3600.765950213228;3606.747527673038;3615.1323682316056;3635.6727894489622;4132.91734165315;4206.221848957892;4235;4280.59334363235;4316.6546676265825;4925.605951523869;4938.555530002245;4939.728314942713;4943.134951383566;4960.479149689303;4234.2801723706425;4246.639035682002;4248.808803603845;4249.87250382489;4291.570842915684;4285.807138678767;4315.741055536678;4385.057212699285;4406.845760398371;4420.668449866273;4727.763611819395;4733.100710864925;4745.620350372031;4748.240281554935;4794.993051459163;4774.546418090275;4950.183219768698;4959.429665588504;4963.602911767122;5012.4736902626155;4665.650076244227;4725.054989002282;4730.030343779448;4752.52474752522;4771.308160316666;4838.7338696372035;4871.318015477765;4875.366202393666;4877.463479017376;4921.163402221702;4807.4471435785335;4839.879003024953;4912.312276281252;4935.161022626234;5004.84985450437;4759.666823322473;4770.594499467584;4778.808847646055;4781.330613714153;4821.7589120544535;4779.904401911873;4780.378550788375;4780.760961951958;4782.784774685217;4815.22956326986;4526.434195725535;4634.629229661687;4673.6494762892235;4701.694389864648;4706.270528068155;4798;4803.567678908776;4803.711777293373;4822.614190864652;4824.155772739827;4730;4735.479097299225;4736.928946065881;4764.42826860765;4767.261074533453 18:29:43 INFO - PROCESS | 1860 | |1;ext.html;500.3545426399944;502.22406382139593;538.9811356602519;548.8545535433111;553.0570377506352;24710.382240443974;25183.99264029439;33244.50133248;33697.326053478915;33748.32503349938;36328.27343453129;36768.632313676855;36827.81586092066;36829.63170368302;36877.446838297445;6704.765333213339;7542.283483069114;7774.611269436534;7776.416768742339;7781.766547003599;9679.564419601134;9927.851082233772;9928.851067233998;9930.751731206741;9933.850992235122;9755.463449510275;9878.802423951516;9879.3578417403;9887.802243955117;9905.108540231413;6821.727130914757;9449.81100377992;9495.003024682412;9751.90248097517;10043.949780251125;9499.572519236652;9647.324687271894;9651.372660777028;9654.613815447445;9654.90345096547;33947.15132121692;34378.14054648654;34403.655963440295;34441;34442;2683.3962358469385;2707.296103013211;2794.7484726374723;3329.716974057208;3417.8545231062044;24847.87576062126;24895.62656560153;24936.127235546668;25465.61801572978;25684;3435.639257877937;3466.9479957800654;3491.109767009422;3492.266624008961;3496.4405695088662;226603;228749.85625071934;229082;229402;229434;55216;55505.44494555003;55557.72221138949;55564;55577.1663425049;59785.70107149436;59806.40193598008;59844;59856;60006;12150.45322960469;12230.694232644255;12281.447334869774;12350.691232719075;12354.0734444917;7609.809754756065;9078.727638170865;9373.953130234306;9539.47532885698;9635.325527213028;18238.361657341928;18295.72556411655;18365.173567189508;18366.540836479195;18442.07789610541;7310.195878453366;7639.656215470317;7660.310572048431;7754.961225193838;7790.104138024087;794.5749024272102;824.6124321568853;838.9203025712548;885.3890815337396;943.6602822983721;25772.742272577034;26776;26979.32551686184;27020.864895675397;27298.5905211422;903.4714691905309;919.384012711485;971.5385192033727;1018.4093225928943;1059.9894001060045;13514.189148651112;13799.2410417428;14072.648183795282;14114.85885141156;14143.858561414254;258169;261997;262175;263407;263480;46016.30975535369;46531;46539.30191047137;46583.53416465792;46692.7665361671;886.4415418286567;1098.2970898624887;1115.1357697784283;1122.7473818390797;1136.6362763915633;23741.762582374646;24421;24713.990694434222;26252.73747262503;26743.732562674904;35279;36457.270854583294;36647.63352366442;36697.63302366942;36769.08077298089;177499;178006;178707.10646446684;178957;179113;23842.165524206568;28242.717572824007;28603.427931440838;28879.133625991253;28896.277593060342;32887.342253154326;41576.58423415727;42169;42238.044569963095;43337.13325733531;32955.27902195815;33087.66912330846;33702.49446258259;33815.49276760801;34005.319893602486;33036.50445243371;33272.83363583167;33334.66665333316;33343.66656333405;33522;32907.8354608235;33287.334253314315;33724.662753372155;33735.662643374235;33848.3230335387;27851.303717406416;29626.407471850012;30128.849355753082;30200.24499387445;30345.393092138474;23345.766542335037;23651;23979.28062158138;24037.278881633578;24038.87980560086 18:29:43 INFO - PROCESS | 1860 | |2;jquery.html;326.37987823136024;332.9760984971213;334.9899503014909;335.78509753757584;338.31153602419084;14604.05073670212;14847.480338188165;15374.769378459332;15505.844941550582;16277.267522961465;14354;14537.273136343167;14822.110673359606;15379.69240615187;15383.307751151196;4855.781489832948;5042.949570504285;5044.848654540369;5045.318881950945;5065.189569668853;4916.901661966758;4967.726775027372;4988.201887697969;5061.519155680223;5066.113430149728;4983.302337672729;4994.0261648978285;5002.7248501332415;5004.12427825131;5036.798528058874;4884.365032545782;4977.203647416414;4988.326575912241;4989.57588604969;5087.56755675768;4867.318575399447;4870.756462176877;4901.828436004758;4903.068417000758;4907.901841963141;11641.825372619418;11881.227720198245;11940.164188506807;11959.342236177006;12068.758624827455;1565.3503795924678;1647.176411794103;1694.186790340631;1746.7903851537897;2020.3736841579012;8781.20969112783;8853.911460885372;9168.770780730536;9184.403013804082;11829;1720.329071662053;1748.1521462090875;1751.422030729856;1783.4521473459376;1796.514940965945;53853;55541.44458555403;55805;57306.71346643282;57482.425175748125;9676.838779346523;9679.854802177973;9688.854667179998;9757.512124393752;9904.504774761233;12388.31864247457;12486;12500.124991250525;12501.812472812915;12514.249145051326;6439.678016099177;6481.449076828428;6490.286068532458;6579.506537009744;6583.703733332011;6015.729292181863;6047;6112;6125.601835880653;6134.2332208473945;4101.733387329814;4187.099773548702;4191.685623578243;4224.683148763855;4226.281532139544;1682.848543631079;1735.5053809664184;1735.947921562355;1762.9294828206728;1773.2552328022261;810.4124509730516;811.7645882694071;813.4062134641745;829.1749709039544;964.9951750241204;14986.775198372034;15109.168995705122;15190.46833360827;15284.465043723416;15546.455874044354;812.1837553258937;832.3050253038659;848.5502683577714;862.4437237981467;898.2275243290765;8441.36689748259;8709.259712924346;8711.782205444915;8920.776980575538;8948.821023579492;346775;348754;354140;354302;355720;58481.415185847596;61793.38206617876;62564;64223.678881605294;65502.67248663726;882.3117967984982;889.6485888074304;893.2362829780574;908.404994728454;909.4270609515962;13405.396757145756;13656;13736.351637803127;13830.446782128602;13928.72142557123;28830.135095947157;28984.855075724485;30049.54925676073;30308.696913030588;30836.229094271926;39232.411513826744;40626.35928664627;40671;41238.58761412348;42550.36174457324;6899.75850845218;7112.57324560528;7183;7190.06529151207;7273.927260727537;8862.689805856764;10491.632792852213;11002;11134.3876086816;11215.71960700989;8890.555472226491;9050.09499050116;9168.633254669738;9334.71995840126;9494.525273736424;9691.757706057406;9848.212143028684;9850.507474626384;9853.901460985586;10080.243981701255;9555.952220238854;9679.177269932135;9934;9935.801283974424;9969.700908972742;7118;7139.357457828821;7226.205117436973;7236.20401755796;7328.3404493595835;8727.91272087271;9073.637054517745;9220.723378298662;9466.95266523663;10049.447280399649 18:29:43 INFO - PROCESS | 1860 | |3;mootools.html;1079.13129930406;1347.723716638089;1351.1757827725082;1453.7673972164448;1700.7448882667597;6191.35928978821;6797.9320206797975;6961.095057642512;6988.440924726023;6990.26602206768;6940.201876784171;7116.217216106224;7144.857102857953;7149.49953503255;7153.141623005234;1794.55136215946;2076.1384025629422;2121.7772133925946;2125.0224896547606;2154.062982602573;2130.3928380411585;2139.775323591024;2143.3355659745453;2143.5605700831293;2144.035184167123;2053.117159621362;2086.864353816997;2089.174775963501;2090.9268175613856;2092.853500254983;2065.2461851424273;2076.14877900061;2085.7288552488153;2112.9963267447993;2139.4437446264083;2103.7580678221893;2117.841161912863;2127.106615221611;2128.1061953979365;2128.8403369747175;7216.3505284524645;7260.45546584003;7267.709291628328;7270.818229544251;7275;4188.895277618053;4275.893102672427;4290.69965102443;4293.914121717548;4311.956880431187;2664.5869890167055;2699.5140874642557;2737.9726202737916;2741.2735625059377;2913.2134323732475;890.0520945193413;896.5162655804654;898.4923518212189;909.1817364372052;921.7603423109973;9548.61805527785;9595.90404095964;9606.471644059575;9635.277354198393;9642.180414664692;3901.141748815256;3981.7411868228473;4038.273110840018;4072.3077076897;4076.3885417187066;8079.353651707849;8097.433179677366;8099.311558517592;8117.0665373481625;8121.390895682729;3653.780773153619;4289.485261768607;4291.077418355068;4292.527821939647;4297.09760950204;3791.431285307226;3825.5600605930117;3828.942565861514;3846.2692088503095;3880.3985382265796;3281.5405843181975;3368.9663103369144;3387.8983630491125;3399.6430374810784;3428.7428442866885;1044.7127040064042;1057.2282233969245;1059.0891833023593;1064.2656566968767;1071.1484369925927;1084.9186311026704;1091.5251865438559;1095.05277934586;1098.5441041967654;1143.857017872766;6695.430888374445;6728.831779205559;6732.831679208059;6759.763408280686;6774.220964589037;1062.5909025025421;1080.6271836216492;1085.2511766880828;1101.498818037791;1112.1603189591806;5097.949020509822;5215.608829337815;5249.028929648028;5278.9472105278455;5288.286081379041;8538.615762290712;8745.431546949429;8877.911220887838;8885.333599980027;8893.333000025024;8527.957360213159;8623;8696.826063478695;8705.869411958825;8714.782130446663;6763.323667633197;6910.20532638753;6913.75801846933;6915.343042410963;6963.442924566022;6340.175777148941;6429.7428102875365;6459.063435801876;6460.515461340325;6469.061986012096;7293.161286452126;7631.198724133886;7684.884726728992;7691.077230692327;7705.383569314329;7494.475386722877;7689.9615501922135;7777.105632852295;7785.922140778746;7790.376769858511;5797.826065218051;5834.94165058344;5918.644881307136;5939.732712027882;5947.137665038632;6746.628935408599;6765.188177418741;6780.118584583973;6783.864322713617;6807.285235050248;5915.201447804491;6096.939030609815;6106.2061931948565;6153.723082461211;6292.4966002720585;6100.633961962297;6129.325774164749;6134.938650613615;6197.845053873689;6285.057241413641;6300.59046161998;6339.366063393623;6354.809355719336;6361.936380636134;6376.521760868046;5723.7996670116345;5798.391168927202;5803.65178089316;5824;5828.854278642898;5932.940670593239;6028.969855150696;6054.848628784315;6070.332263450929;6092.238470191226 18:29:43 INFO - PROCESS | 1860 | |4;prototype.html;289.7812151825372;290.6178375436301;293.2902376249476;293.41463779759385;294.5169921329021;5189.221616757488;5290.312259406282;5290.656107353019;5295.602829787762;5299.390570084442;5214.556762675177;5278.868028299295;5282.683039017662;5283.947160528403;5288.709120998344;3860.1507668313066;3969.8412063517426;4032.8588499402526;4076.449679293302;4088.4276201331836;4098.938515922248;4108.219438306712;4111.97944010281;4114.670826333886;4119.917601647965;3851.4222866569958;4073;4090.6318431341174;4091.079507110891;4096.262672718909;3964.980175099135;4012.498437695288;4020.959790402088;4022.1754540319166;4039.454673619053;3566.696830769388;3570.80360580168;3573.1960308930543;3576.3920133577353;3576.8554062699945;5066.645334826564;5073.619478539124;5089.058524173003;5092.00705862357;5097.770600322994;4665.346851440801;4674.135284972291;4677.859664210045;4682.438107427097;4683.274092515631;5524.751386187591;5525.530329921921;5529.751161197756;5533.059379905426;5534.252875861747;3771.641694039062;3877.941830872539;3880.611938806125;3886.24218277436;3886.397608370707;5797.507211886995;5808.535317174616;5811.476967072984;5814.709264536757;5830.621009634403;3958.802059896994;3991.7604943703473;3993.880183594497;3995.400689896481;3998.800059997047;4050.8784736457956;4060.878173654795;4061.939070913939;4062.6546743527133;4063.3701776224734;4615.353850460938;4632.629389648888;4639.188142075123;4648.930266046012;4649.907001860011;5503.779848806083;5515.034868897927;5519.227308176858;5524.530414914697;5531.225628412026;1404.3118871752768;1432.0333774702035;1434.863687949643;1435.612384656158;1437.23826372023;831.8502669519545;872.4067634008808;892.2371372476568;907.5689047702289;917.1974522292994;4775.761211939389;4782.856514304576;4795.20879054959;4801;4801.279808028824;5628.099504079328;5702.600817942704;5708;5709.058005429058;5716;4791.089692958327;4842.467328593852;4866.6106711463;4868.634852386014;4871.464138944713;3033.7421319187674;3075.2004478835215;3078.3227689908185;3081.0910781319562;3083.4141513112436;5452.754626041838;5462;5498.615096943256;5516.862078448071;5525;5689.34572524165;5827.912581311284;5865.266841644794;5872.618279811884;5874;5415.458454154553;5441.755121019563;5445.319335083114;5448.945510544844;5451.509364157245;5698.715064246689;5709.257796486596;5711.485966263056;5711.857203569778;5713.400092990176;5561.082421400423;5579.553635709052;5581.413951535031;5582.888342233214;5586.245856809279;5434.619576629598;5436.619436639556;5441.047816632153;5450.1007333789485;5457.045017121908;3773.289570870252;3833.3291673956387;3877.825497852547;3880.0493878998695;3880.3403421418993;5675.31896172462;5696.715164241854;5701.657900525982;5708.828735137952;5708.885822283614;5496.038193316233;5503.3120859892515;5507.752151153128;5512.641678290898;5512.834614961557;5488.1493368527945;5497.065498865122;5497.972510137423;5499.312585926759;5505.944940550704;5341.278927344914;5353.705546194997;5354.7590358434745;5360.785568577369;5368.731563421891;5399.892002160013;5485.862853428696;5548.833534993957;5554.08357620988;5558.249636299048;5374.328208973879;5401.297831281908;5401.459854014567;5408.972295263888;5412.269343638716 18:29:43 INFO - PROCESS | 1860 | |5;yui.html;555.9694216818078;560.9467100625442;624.9999999999999;659.3241927024799;670.4401824476562;10655.200859935507;10775.784484310308;11424.485898134582;11741.23681960672;11768.411579421037;10536.36781793093;10554.525046372912;10752.03231709146;11001.394923279217;11094;595.5741644724021;746.2612014106037;749.8687729647318;753.758797184901;754.1666458563291;767.03736810303;769.4882902869613;774.3069952392606;774.3804956035177;775.11249619186;812.8943237379162;816.5019338203691;816.742726041298;817.146082343952;817.4114637461018;623.6538721009861;794.7774623105539;809.4697972827807;809.554744890308;811.1037303779327;597.5787070115558;598.2730981857064;598.4404581716109;598.4703537369415;599.2030599302917;11814.113941454425;11843.407829608484;11887.049036077093;11902.34537100459;11912.225705329125;10249.282550221487;11089.667309980714;11130.38782866942;11392;11617.593384231595;9356.90643093567;9374.343795934288;9432.764180895463;9547.761305967337;9687.515624218831;3127.2807254331633;3193.2655489237604;3197.4244635965515;3206.406814739281;3241.9837900810344;41632.37551436731;41668.1666366671;41861.790691046655;42041.369379459335;42079.579204207876;7949.523028618301;8049.356051515864;8194.795130121676;8267.751967440987;8362.498250105013;15058.698826023638;15942.60143496422;16388.75416868748;16466.917665411835;16521.91739041321;6654.168228971379;6740;6754.45964322853;6789.830254243683;6798.082258895085;3580.803055831902;3632.4914511968345;3672.265546890633;3740.0649837540614;3740.682042026458;2643.960340594893;2644.259607309956;2672.198340497882;2672.679278486594;2683.3023413912524;431.15923948300315;467.4881005299192;476.142942703133;481.0859367202274;484.5082241524855;436.52418863439004;440.6562880952862;526.1739069660673;533.2987121934643;548.4323724944663;6928.688209030505;7213.935289093673;7286.198518162998;7364.742234021891;7449.404047676173;432.9567043295645;477.4437779986277;516.6564234783901;540.0629907111158;551.0879494436714;3209.3741720364305;3348.514465402503;3399.7110245628905;3462.532558104674;3505.5968563615;50692;51085;51456;51874.48125518772;51875.22187167196;44531;45104.548954510035;45510.54489455063;45678.77160614176;45757.54242457533;41197.38203926943;41441.378379324335;41575.37636935448;41984.58015419807;42023.57976420258;6794.76218332356;6850.862982740417;6895.931040689529;6898.310168983062;6910.412614927787;29500.409991799614;30036.399272014874;30701.692983070778;31025.224369390944;31296;39378.60621393749;39847.80076099601;39986.60013399829;40370.79814601026;41169.1766164669;9797.167240784613;9966.202703783825;9987.650432234837;10169.694909152737;10173.389596624227;10619.787604248026;10744;10797.514111865143;10810.405427701551;10986.176036797113;7327.303906128909;8372.125269893048;9574.521273936414;9892.455914924749;10228.590856365661;8702.390832641655;8873.955630221808;8893.911060889566;9078.773030674285;9113;9203.447793132433;9343;9355.719328420158;9392.483413412328;9550.235981121356;8110.391720620859;8283;8325.748645946773;8445.240226797823;9040.593173307348;7791.805204869924;8128.14654461273;8185.959070204849;8228.177182281725;8268.627911743866 18:29:43 INFO - PROCESS | 1860 | __end_tp_report 18:29:43 INFO - PROCESS | 1860 | __start_cc_report 18:29:43 INFO - PROCESS | 1860 | _x_x_mozilla_cycle_collect,849 18:29:43 INFO - PROCESS | 1860 | __end_cc_report 18:29:43 INFO - PROCESS | 1860 | __startTimestamp1457490583027__endTimestamp 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - PROCESS | 1860 | ------- Summary: start ------- 18:29:43 INFO - PROCESS | 1860 | Number of tests: 6 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - PROCESS | 1860 | [#0] dojo.html Cycles:165 Average:4550.66 Median:4727.76 stddev:476.68 (10.1%) stddev-sans-first:451.59 18:29:43 INFO - PROCESS | 1860 | Values: 2550.9 2590.0 2621.2 2640.4 2643.2 4533.7 4535.8 4559.3 4562.9 4635.3 4587.2 4607.1 4609.0 4610.6 4616.2 4192.4 4264.9 4295.1 4373.9 4378.1 4109.8 4281.1 4336.2 4336.8 4346.0 4188.2 4229.9 4271.3 4289.5 4290.9 4223.5 4231.1 4231.4 4266.3 4271.7 4088.3 4220.2 4222.1 4226.7 4250.4 4483.6 4555.6 4586.8 4597.3 4610.9 4909.3 4934.3 4935.1 4936.0 4973.9 4833.1 4922.7 4939.8 4957.3 4993.5 4556.6 4571.1 4578.1 4581.5 4611.4 5016.7 5025.0 5027.1 5031.1 5061.2 4738.5 4782.9 4826.0 4842.0 4890.4 4975.0 4993.4 4995.0 4995.2 4996.0 4942.1 4946.8 4947.0 4947.1 4953.2 4728.2 4799.6 4891.4 4891.6 4942.7 4074.5 4079.2 4082.9 4100.6 4114.5 3595.8 3600.8 3606.7 3615.1 3635.7 4132.9 4206.2 4235.0 4280.6 4316.7 4925.6 4938.6 4939.7 4943.1 4960.5 4234.3 4246.6 4248.8 4249.9 4291.6 4285.8 4315.7 4385.1 4406.8 4420.7 4727.8 4733.1 4745.6 4748.2 4795.0 4774.5 4950.2 4959.4 4963.6 5012.5 4665.7 4725.1 4730.0 4752.5 4771.3 4838.7 4871.3 4875.4 4877.5 4921.2 4807.4 4839.9 4912.3 4935.2 5004.8 4759.7 4770.6 4778.8 4781.3 4821.8 4779.9 4780.4 4780.8 4782.8 4815.2 4526.4 4634.6 4673.6 4701.7 4706.3 4798.0 4803.6 4803.7 4822.6 4824.2 4730.0 4735.5 4736.9 4764.4 4767.3 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - PROCESS | 1860 | [#1] ext.html Cycles:180 Average:38456.08 Median:33897.74 stddev:58742.91 (173.3%) stddev-sans-first:58838.56 18:29:43 INFO - PROCESS | 1860 | Values: 500.4 502.2 539.0 548.9 553.1 24710.4 25184.0 33244.5 33697.3 33748.3 36328.3 36768.6 36827.8 36829.6 36877.4 6704.8 7542.3 7774.6 7776.4 7781.8 9679.6 9927.9 9928.9 9930.8 9933.9 9755.5 9878.8 9879.4 9887.8 9905.1 6821.7 9449.8 9495.0 9751.9 10043.9 9499.6 9647.3 9651.4 9654.6 9654.9 33947.2 34378.1 34403.7 34441.0 34442.0 2683.4 2707.3 2794.7 3329.7 3417.9 24847.9 24895.6 24936.1 25465.6 25684.0 3435.6 3466.9 3491.1 3492.3 3496.4 226603.0 228749.9 229082.0 229402.0 229434.0 55216.0 55505.4 55557.7 55564.0 55577.2 59785.7 59806.4 59844.0 59856.0 60006.0 12150.5 12230.7 12281.4 12350.7 12354.1 7609.8 9078.7 9374.0 9539.5 9635.3 18238.4 18295.7 18365.2 18366.5 18442.1 7310.2 7639.7 7660.3 7755.0 7790.1 794.6 824.6 838.9 885.4 943.7 25772.7 26776.0 26979.3 27020.9 27298.6 903.5 919.4 971.5 1018.4 1060.0 13514.2 13799.2 14072.6 14114.9 14143.9 258169.0 261997.0 262175.0 263407.0 263480.0 46016.3 46531.0 46539.3 46583.5 46692.8 886.4 1098.3 1115.1 1122.7 1136.6 23741.8 24421.0 24714.0 26252.7 26743.7 35279.0 36457.3 36647.6 36697.6 36769.1 177499.0 178006.0 178707.1 178957.0 179113.0 23842.2 28242.7 28603.4 28879.1 28896.3 32887.3 41576.6 42169.0 42238.0 43337.1 32955.3 33087.7 33702.5 33815.5 34005.3 33036.5 33272.8 33334.7 33343.7 33522.0 32907.8 33287.3 33724.7 33735.7 33848.3 27851.3 29626.4 30128.8 30200.2 30345.4 23345.8 23651.0 23979.3 24037.3 24038.9 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - PROCESS | 1860 | [#2] jquery.html Cycles:180 Average:21266.42 Median:4991.80 stddev:57763.96 (1157.2%) stddev-sans-first:57904.60 18:29:43 INFO - PROCESS | 1860 | Values: 326.4 333.0 335.0 335.8 338.3 14604.1 14847.5 15374.8 15505.8 16277.3 14354.0 14537.3 14822.1 15379.7 15383.3 4855.8 5042.9 5044.8 5045.3 5065.2 4916.9 4967.7 4988.2 5061.5 5066.1 4983.3 4994.0 5002.7 5004.1 5036.8 4884.4 4977.2 4988.3 4989.6 5087.6 4867.3 4870.8 4901.8 4903.1 4907.9 11641.8 11881.2 11940.2 11959.3 12068.8 1565.4 1647.2 1694.2 1746.8 2020.4 8781.2 8853.9 9168.8 9184.4 11829.0 1720.3 1748.2 1751.4 1783.5 1796.5 53853.0 55541.4 55805.0 57306.7 57482.4 9676.8 9679.9 9688.9 9757.5 9904.5 12388.3 12486.0 12500.1 12501.8 12514.2 6439.7 6481.4 6490.3 6579.5 6583.7 6015.7 6047.0 6112.0 6125.6 6134.2 4101.7 4187.1 4191.7 4224.7 4226.3 1682.8 1735.5 1735.9 1762.9 1773.3 810.4 811.8 813.4 829.2 965.0 14986.8 15109.2 15190.5 15284.5 15546.5 812.2 832.3 848.6 862.4 898.2 8441.4 8709.3 8711.8 8920.8 8948.8 346775.0 348754.0 354140.0 354302.0 355720.0 58481.4 61793.4 62564.0 64223.7 65502.7 882.3 889.6 893.2 908.4 909.4 13405.4 13656.0 13736.4 13830.4 13928.7 28830.1 28984.9 30049.5 30308.7 30836.2 39232.4 40626.4 40671.0 41238.6 42550.4 6899.8 7112.6 7183.0 7190.1 7273.9 8862.7 10491.6 11002.0 11134.4 11215.7 8890.6 9050.1 9168.6 9334.7 9494.5 9691.8 9848.2 9850.5 9853.9 10080.2 9556.0 9679.2 9934.0 9935.8 9969.7 7118.0 7139.4 7226.2 7236.2 7328.3 8727.9 9073.6 9220.7 9467.0 10049.4 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - PROCESS | 1860 | [#3] mootools.html Cycles:180 Average:4957.29 Median:5943.44 stddev:2554.44 (43.0%) stddev-sans-first:2544.97 18:29:43 INFO - PROCESS | 1860 | Values: 1079.1 1347.7 1351.2 1453.8 1700.7 6191.4 6797.9 6961.1 6988.4 6990.3 6940.2 7116.2 7144.9 7149.5 7153.1 1794.6 2076.1 2121.8 2125.0 2154.1 2130.4 2139.8 2143.3 2143.6 2144.0 2053.1 2086.9 2089.2 2090.9 2092.9 2065.2 2076.1 2085.7 2113.0 2139.4 2103.8 2117.8 2127.1 2128.1 2128.8 7216.4 7260.5 7267.7 7270.8 7275.0 4188.9 4275.9 4290.7 4293.9 4312.0 2664.6 2699.5 2738.0 2741.3 2913.2 890.1 896.5 898.5 909.2 921.8 9548.6 9595.9 9606.5 9635.3 9642.2 3901.1 3981.7 4038.3 4072.3 4076.4 8079.4 8097.4 8099.3 8117.1 8121.4 3653.8 4289.5 4291.1 4292.5 4297.1 3791.4 3825.6 3828.9 3846.3 3880.4 3281.5 3369.0 3387.9 3399.6 3428.7 1044.7 1057.2 1059.1 1064.3 1071.1 1084.9 1091.5 1095.1 1098.5 1143.9 6695.4 6728.8 6732.8 6759.8 6774.2 1062.6 1080.6 1085.3 1101.5 1112.2 5097.9 5215.6 5249.0 5278.9 5288.3 8538.6 8745.4 8877.9 8885.3 8893.3 8528.0 8623.0 8696.8 8705.9 8714.8 6763.3 6910.2 6913.8 6915.3 6963.4 6340.2 6429.7 6459.1 6460.5 6469.1 7293.2 7631.2 7684.9 7691.1 7705.4 7494.5 7690.0 7777.1 7785.9 7790.4 5797.8 5834.9 5918.6 5939.7 5947.1 6746.6 6765.2 6780.1 6783.9 6807.3 5915.2 6096.9 6106.2 6153.7 6292.5 6100.6 6129.3 6134.9 6197.8 6285.1 6300.6 6339.4 6354.8 6361.9 6376.5 5723.8 5798.4 5803.7 5824.0 5828.9 5932.9 6029.0 6054.8 6070.3 6092.2 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - PROCESS | 1860 | [#4] prototype.html Cycles:180 Average:4576.77 Median:5289.51 stddev:1350.03 (25.5%) stddev-sans-first:1314.91 18:29:43 INFO - PROCESS | 1860 | Values: 289.8 290.6 293.3 293.4 294.5 5189.2 5290.3 5290.7 5295.6 5299.4 5214.6 5278.9 5282.7 5283.9 5288.7 3860.2 3969.8 4032.9 4076.4 4088.4 4098.9 4108.2 4112.0 4114.7 4119.9 3851.4 4073.0 4090.6 4091.1 4096.3 3965.0 4012.5 4021.0 4022.2 4039.5 3566.7 3570.8 3573.2 3576.4 3576.9 5066.6 5073.6 5089.1 5092.0 5097.8 4665.3 4674.1 4677.9 4682.4 4683.3 5524.8 5525.5 5529.8 5533.1 5534.3 3771.6 3877.9 3880.6 3886.2 3886.4 5797.5 5808.5 5811.5 5814.7 5830.6 3958.8 3991.8 3993.9 3995.4 3998.8 4050.9 4060.9 4061.9 4062.7 4063.4 4615.4 4632.6 4639.2 4648.9 4649.9 5503.8 5515.0 5519.2 5524.5 5531.2 1404.3 1432.0 1434.9 1435.6 1437.2 831.9 872.4 892.2 907.6 917.2 4775.8 4782.9 4795.2 4801.0 4801.3 5628.1 5702.6 5708.0 5709.1 5716.0 4791.1 4842.5 4866.6 4868.6 4871.5 3033.7 3075.2 3078.3 3081.1 3083.4 5452.8 5462.0 5498.6 5516.9 5525.0 5689.3 5827.9 5865.3 5872.6 5874.0 5415.5 5441.8 5445.3 5448.9 5451.5 5698.7 5709.3 5711.5 5711.9 5713.4 5561.1 5579.6 5581.4 5582.9 5586.2 5434.6 5436.6 5441.0 5450.1 5457.0 3773.3 3833.3 3877.8 3880.0 3880.3 5675.3 5696.7 5701.7 5708.8 5708.9 5496.0 5503.3 5507.8 5512.6 5512.8 5488.1 5497.1 5498.0 5499.3 5505.9 5341.3 5353.7 5354.8 5360.8 5368.7 5399.9 5485.9 5548.8 5554.1 5558.2 5374.3 5401.3 5401.5 5409.0 5412.3 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - PROCESS | 1860 | [#5] yui.html Cycles:180 Average:12053.28 Median:26195.57 stddev:14197.11 (54.2%) stddev-sans-first:14210.69 18:29:43 INFO - PROCESS | 1860 | Values: 556.0 560.9 625.0 659.3 670.4 10655.2 10775.8 11424.5 11741.2 11768.4 10536.4 10554.5 10752.0 11001.4 11094.0 595.6 746.3 749.9 753.8 754.2 767.0 769.5 774.3 774.4 775.1 812.9 816.5 816.7 817.1 817.4 623.7 794.8 809.5 809.6 811.1 597.6 598.3 598.4 598.5 599.2 11814.1 11843.4 11887.0 11902.3 11912.2 10249.3 11089.7 11130.4 11392.0 11617.6 9356.9 9374.3 9432.8 9547.8 9687.5 3127.3 3193.3 3197.4 3206.4 3242.0 41632.4 41668.2 41861.8 42041.4 42079.6 7949.5 8049.4 8194.8 8267.8 8362.5 15058.7 15942.6 16388.8 16466.9 16521.9 6654.2 6740.0 6754.5 6789.8 6798.1 3580.8 3632.5 3672.3 3740.1 3740.7 2644.0 2644.3 2672.2 2672.7 2683.3 431.2 467.5 476.1 481.1 484.5 436.5 440.7 526.2 533.3 548.4 6928.7 7213.9 7286.2 7364.7 7449.4 433.0 477.4 516.7 540.1 551.1 3209.4 3348.5 3399.7 3462.5 3505.6 50692.0 51085.0 51456.0 51874.5 51875.2 44531.0 45104.5 45510.5 45678.8 45757.5 41197.4 41441.4 41575.4 41984.6 42023.6 6794.8 6850.9 6895.9 6898.3 6910.4 29500.4 30036.4 30701.7 31025.2 31296.0 39378.6 39847.8 39986.6 40370.8 41169.2 9797.2 9966.2 9987.7 10169.7 10173.4 10619.8 10744.0 10797.5 10810.4 10986.2 7327.3 8372.1 9574.5 9892.5 10228.6 8702.4 8874.0 8893.9 9078.8 9113.0 9203.4 9343.0 9355.7 9392.5 9550.2 8110.4 8283.0 8325.7 8445.2 9040.6 7791.8 8128.1 8186.0 8228.2 8268.6 18:29:43 INFO - PROCESS | 1860 | -------- Summary: end -------- 18:29:43 INFO - PROCESS | 1860 | 18:29:43 INFO - TEST-INFO | 1860: exit 0 18:29:43 INFO - TEST-OK | dromaeo_css | took 1117117ms 18:29:43 INFO - TEST-START | kraken 18:29:43 INFO - operating with platform_type : linux_ 18:29:43 INFO - Initialising browser for kraken test... 18:29:43 INFO - TEST-INFO | started process 2042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeCBBQK/profile http://localhost:34528/getInfo.html) 18:29:48 INFO - PROCESS | 2042 | __metrics Screen width/height:1600/1200 18:29:48 INFO - PROCESS | 2042 | colorDepth:24 18:29:48 INFO - PROCESS | 2042 | Browser inner width/height: 1024/697 18:29:48 INFO - PROCESS | 2042 | __metrics 18:29:48 ERROR - PROCESS | 2042 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:29:48 INFO - PROCESS | 2042 | 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. 18:29:49 INFO - TEST-INFO | 2042: exit 0 18:29:49 INFO - Browser initialized. 18:29:49 INFO - Running cycle 1/1 for kraken test... 18:29:49 INFO - TEST-INFO | started process 2125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeCBBQK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:01 INFO - PROCESS | 2125 | RSS: Main: 153251840 18:30:01 INFO - PROCESS | 2125 | 18:30:04 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34528/tests/kraken/driver.html?testName=audio-beat-detection) 18:30:05 INFO - PROCESS | 2125 | RSS: Main: 193761280 18:30:05 INFO - PROCESS | 2125 | 18:30:07 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34528/tests/kraken/driver.html?testName=audio-dft) 18:30:08 INFO - PROCESS | 2125 | RSS: Main: 184946688 18:30:08 INFO - PROCESS | 2125 | 18:30:11 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34528/tests/kraken/driver.html?testName=audio-fft) 18:30:12 INFO - PROCESS | 2125 | RSS: Main: 170799104 18:30:12 INFO - PROCESS | 2125 | 18:30:14 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34528/tests/kraken/driver.html?testName=audio-oscillator) 18:30:14 INFO - PROCESS | 2125 | RSS: Main: 171941888 18:30:14 INFO - PROCESS | 2125 | 18:30:16 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:30:17 INFO - PROCESS | 2125 | RSS: Main: 175398912 18:30:17 INFO - PROCESS | 2125 | 18:30:20 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34528/tests/kraken/driver.html?testName=imaging-darkroom) 18:30:21 INFO - PROCESS | 2125 | RSS: Main: 175685632 18:30:21 INFO - PROCESS | 2125 | 18:30:24 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34528/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:25 INFO - PROCESS | 2125 | RSS: Main: 173142016 18:30:25 INFO - PROCESS | 2125 | 18:30:28 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34528/tests/kraken/driver.html?testName=json-parse-financial) 18:30:28 INFO - PROCESS | 2125 | RSS: Main: 174608384 18:30:28 INFO - PROCESS | 2125 | 18:30:30 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:31 INFO - PROCESS | 2125 | RSS: Main: 182939648 18:30:31 INFO - PROCESS | 2125 | 18:30:33 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34528/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:33 INFO - PROCESS | 2125 | RSS: Main: 180633600 18:30:33 INFO - PROCESS | 2125 | 18:30:35 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:36 INFO - PROCESS | 2125 | RSS: Main: 191787008 18:30:36 INFO - PROCESS | 2125 | 18:30:39 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:39 INFO - PROCESS | 2125 | RSS: Main: 200220672 18:30:39 INFO - PROCESS | 2125 | 18:30:42 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:42 INFO - PROCESS | 2125 | RSS: Main: 197550080 18:30:42 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | Cycle 1(1): loaded http://localhost:34528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34528/tests/kraken/driver.html?testName=ai-astar) 18:30:44 INFO - PROCESS | 2125 | RSS: Main: 259948544 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | __start_tp_report 18:30:44 INFO - PROCESS | 2125 | _x_x_mozilla_page_load 18:30:44 INFO - PROCESS | 2125 | _x_x_mozilla_page_load_details 18:30:44 INFO - PROCESS | 2125 | |i|pagename|runs| 18:30:44 INFO - PROCESS | 2125 | |0;ai-astar;112;112;107;113;113;113;103;115;113;113 18:30:44 INFO - PROCESS | 2125 | |1;audio-beat-detection;153;140;150;172;134;155;158;134;175;131 18:30:44 INFO - PROCESS | 2125 | |2;audio-dft;161;160;161;160;160;159;162;162;162;162 18:30:44 INFO - PROCESS | 2125 | |3;audio-fft;74;74;100;91;73;74;74;109;95;73 18:30:44 INFO - PROCESS | 2125 | |4;audio-oscillator;94;95;145;95;95;95;142;95;94;127 18:30:44 INFO - PROCESS | 2125 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;117;117 18:30:44 INFO - PROCESS | 2125 | |6;imaging-darkroom;147;147;146;147;146;146;146;146;146;146 18:30:44 INFO - PROCESS | 2125 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;96;96 18:30:44 INFO - PROCESS | 2125 | |8;json-parse-financial;68;67;68;68;67;69;68;76;66;66 18:30:44 INFO - PROCESS | 2125 | |9;json-stringify-tinderbox;70;70;70;70;70;70;71;69;70;70 18:30:44 INFO - PROCESS | 2125 | |10;stanford-crypto-aes;84;84;84;83;83;90;83;83;84;82 18:30:44 INFO - PROCESS | 2125 | |11;stanford-crypto-ccm;119;123;119;120;130;123;133;119;139;120 18:30:44 INFO - PROCESS | 2125 | |12;stanford-crypto-pbkdf2;146;137;151;134;150;135;148;146;152;136 18:30:44 INFO - PROCESS | 2125 | |13;stanford-crypto-sha256-iterative;70;72;74;70;69;73;72;72;68;69 18:30:44 INFO - PROCESS | 2125 | __end_tp_report 18:30:44 INFO - PROCESS | 2125 | __start_cc_report 18:30:44 INFO - PROCESS | 2125 | _x_x_mozilla_cycle_collect,1150 18:30:44 INFO - PROCESS | 2125 | __end_cc_report 18:30:44 INFO - PROCESS | 2125 | __startTimestamp1457490644856__endTimestamp 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | ------- Summary: start ------- 18:30:44 INFO - PROCESS | 2125 | Number of tests: 14 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.60 (3.2%) stddev-sans-first:3.81 18:30:44 INFO - PROCESS | 2125 | Values: 112.0 112.0 107.0 113.0 113.0 113.0 103.0 115.0 113.0 113.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:154.00 stddev:15.56 (10.1%) stddev-sans-first:16.47 18:30:44 INFO - PROCESS | 2125 | Values: 153.0 140.0 150.0 172.0 134.0 155.0 158.0 134.0 175.0 131.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 18:30:44 INFO - PROCESS | 2125 | Values: 161.0 160.0 161.0 160.0 160.0 159.0 162.0 162.0 162.0 162.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#3] audio-fft Cycles:10 Average:83.70 Median:74.00 stddev:13.71 (18.5%) stddev-sans-first:14.09 18:30:44 INFO - PROCESS | 2125 | Values: 74.0 74.0 100.0 91.0 73.0 74.0 74.0 109.0 95.0 73.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:95.00 stddev:21.40 (22.5%) stddev-sans-first:22.12 18:30:44 INFO - PROCESS | 2125 | Values: 94.0 95.0 145.0 95.0 95.0 95.0 142.0 95.0 94.0 127.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:30:44 INFO - PROCESS | 2125 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 18:30:44 INFO - PROCESS | 2125 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:30:44 INFO - PROCESS | 2125 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:68.00 stddev:2.87 (4.2%) stddev-sans-first:3.04 18:30:44 INFO - PROCESS | 2125 | Values: 68.0 67.0 68.0 68.0 67.0 69.0 68.0 76.0 66.0 66.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:70.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 18:30:44 INFO - PROCESS | 2125 | Values: 70.0 70.0 70.0 70.0 70.0 70.0 71.0 69.0 70.0 70.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.21 (2.6%) stddev-sans-first:2.35 18:30:44 INFO - PROCESS | 2125 | Values: 84.0 84.0 84.0 83.0 83.0 90.0 83.0 83.0 84.0 82.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:123.00 stddev:7.06 (5.7%) stddev-sans-first:7.20 18:30:44 INFO - PROCESS | 2125 | Values: 119.0 123.0 119.0 120.0 130.0 123.0 133.0 119.0 139.0 120.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:147.00 stddev:7.18 (4.9%) stddev-sans-first:7.56 18:30:44 INFO - PROCESS | 2125 | Values: 146.0 137.0 151.0 134.0 150.0 135.0 148.0 146.0 152.0 136.0 18:30:44 INFO - PROCESS | 2125 | 18:30:44 INFO - PROCESS | 2125 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:72.00 stddev:1.97 (2.7%) stddev-sans-first:2.06 18:30:44 INFO - PROCESS | 2125 | Values: 70.0 72.0 74.0 70.0 69.0 73.0 72.0 72.0 68.0 69.0 18:30:44 INFO - PROCESS | 2125 | -------- Summary: end -------- 18:30:44 INFO - PROCESS | 2125 | 18:30:45 INFO - TEST-INFO | 2125: exit 0 18:30:45 INFO - TEST-OK | kraken | took 62157ms 18:30:45 INFO - SUITE-END | took 1179s 18:30:46 INFO - Completed test suite (00:19:39) 18:30:46 INFO - javascript benchmark 18:30:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2550.897964081437, 2590.0, 2621.1612284069092, 2640.4059086705483, 2643.1806140096573, 4533.682642215046, 4535.750533720644, 4559.338895860098, 4562.863114106578, 4635.258358662614, 4587.174308624446, 4607.124646317197, 4609.014998457356, 4610.5850473457385, 4616.238320677085, 4192.434021407102, 4264.89337766556, 4295.119500502406, 4373.890652733691, 4378.080603073358, 4109.794510274474, 4281.100968796556, 4336.154449882259, 4336.804843782022, 4346.0, 4188.225178341986, 4229.873103806891, 4271.273883439822, 4289.4852617685765, 4290.914181716379, 4223.493180818291, 4231.090315582164, 4231.386448964914, 4266.317389217741, 4271.743695378287, 4088.34586466164, 4220.240356735786, 4222.050038741289, 4226.682998775073, 4250.426192464009, 4483.596476317114, 4555.612772914306, 4586.793594288265, 4597.264437689953, 4610.9077818443775, 4909.2881532177635, 4934.284528743348, 4935.111679897617, 4936.037472692827, 4973.850784476472, 4833.130036593412, 4922.655414121013, 4939.753012349404, 4957.281194226853, 4993.450720420751, 4556.589906908394, 4571.108633816374, 4578.061497393093, 4581.496035436099, 4611.4005179326805, 5016.724080175552, 5024.974875125601, 5027.145385284511, 5031.144705400091, 5061.164907790247, 4738.47876733559, 4782.880427989258, 4825.95174048262, 4841.95158048415, 4890.388701412324, 4975.0, 4993.425756038029, 4994.950050499521, 4995.200767877195, 4995.975020124876, 4942.110420124341, 4946.777395017233, 4947.0, 4947.060058588857, 4953.157963146202, 4728.1962066448095, 4799.592034677022, 4891.364122664031, 4891.584215341664, 4942.654014218971, 4074.5314288856566, 4079.1637714268504, 4082.897927551835, 4100.5899410058755, 4114.506259248909, 3595.82020898954, 3600.765950213228, 3606.747527673038, 3615.1323682316056, 3635.6727894489622, 4132.91734165315, 4206.221848957892, 4235.0, 4280.59334363235, 4316.6546676265825, 4925.605951523869, 4938.555530002245, 4939.728314942713, 4943.134951383566, 4960.479149689303, 4234.2801723706425, 4246.639035682002, 4248.808803603845, 4249.87250382489, 4291.570842915684, 4285.807138678767, 4315.741055536678, 4385.057212699285, 4406.845760398371, 4420.668449866273, 4727.763611819395, 4733.100710864925, 4745.620350372031, 4748.240281554935, 4794.993051459163, 4774.546418090275, 4950.183219768698, 4959.429665588504, 4963.602911767122, 5012.4736902626155, 4665.650076244227, 4725.054989002282, 4730.030343779448, 4752.52474752522, 4771.308160316666, 4838.7338696372035, 4871.318015477765, 4875.366202393666, 4877.463479017376, 4921.163402221702, 4807.4471435785335, 4839.879003024953, 4912.312276281252, 4935.161022626234, 5004.84985450437, 4759.666823322473, 4770.594499467584, 4778.808847646055, 4781.330613714153, 4821.7589120544535, 4779.904401911873, 4780.378550788375, 4780.760961951958, 4782.784774685217, 4815.22956326986, 4526.434195725535, 4634.629229661687, 4673.6494762892235, 4701.694389864648, 4706.270528068155, 4798.0, 4803.567678908776, 4803.711777293373, 4822.614190864652, 4824.155772739827, 4730.0, 4735.479097299225, 4736.928946065881, 4764.42826860765, 4767.261074533453], "unit": "score", "name": "dojo.html", "value": 4520.519884455302}, {"lowerIsBetter": false, "replicates": [500.3545426399944, 502.22406382139593, 538.9811356602519, 548.8545535433111, 553.0570377506352, 24710.382240443974, 25183.99264029439, 33244.50133248, 33697.326053478915, 33748.32503349938, 36328.27343453129, 36768.632313676855, 36827.81586092066, 36829.63170368302, 36877.446838297445, 6704.765333213339, 7542.283483069114, 7774.611269436534, 7776.416768742339, 7781.766547003599, 9679.564419601134, 9927.851082233772, 9928.851067233998, 9930.751731206741, 9933.850992235122, 9755.463449510275, 9878.802423951516, 9879.3578417403, 9887.802243955117, 9905.108540231413, 6821.727130914757, 9449.81100377992, 9495.003024682412, 9751.90248097517, 10043.949780251125, 9499.572519236652, 9647.324687271894, 9651.372660777028, 9654.613815447445, 9654.90345096547, 33947.15132121692, 34378.14054648654, 34403.655963440295, 34441.0, 34442.0, 2683.3962358469385, 2707.296103013211, 2794.7484726374723, 3329.716974057208, 3417.8545231062044, 24847.87576062126, 24895.62656560153, 24936.127235546668, 25465.61801572978, 25684.0, 3435.639257877937, 3466.9479957800654, 3491.109767009422, 3492.266624008961, 3496.4405695088662, 226603.0, 228749.85625071934, 229082.0, 229402.0, 229434.0, 55216.0, 55505.44494555003, 55557.72221138949, 55564.0, 55577.1663425049, 59785.70107149436, 59806.40193598008, 59844.0, 59856.0, 60006.0, 12150.45322960469, 12230.694232644255, 12281.447334869774, 12350.691232719075, 12354.0734444917, 7609.809754756065, 9078.727638170865, 9373.953130234306, 9539.47532885698, 9635.325527213028, 18238.361657341928, 18295.72556411655, 18365.173567189508, 18366.540836479195, 18442.07789610541, 7310.195878453366, 7639.656215470317, 7660.310572048431, 7754.961225193838, 7790.104138024087, 794.5749024272102, 824.6124321568853, 838.9203025712548, 885.3890815337396, 943.6602822983721, 25772.742272577034, 26776.0, 26979.32551686184, 27020.864895675397, 27298.5905211422, 903.4714691905309, 919.384012711485, 971.5385192033727, 1018.4093225928943, 1059.9894001060045, 13514.189148651112, 13799.2410417428, 14072.648183795282, 14114.85885141156, 14143.858561414254, 258169.0, 261997.0, 262175.0, 263407.0, 263480.0, 46016.30975535369, 46531.0, 46539.30191047137, 46583.53416465792, 46692.7665361671, 886.4415418286567, 1098.2970898624887, 1115.1357697784283, 1122.7473818390797, 1136.6362763915633, 23741.762582374646, 24421.0, 24713.990694434222, 26252.73747262503, 26743.732562674904, 35279.0, 36457.270854583294, 36647.63352366442, 36697.63302366942, 36769.08077298089, 177499.0, 178006.0, 178707.10646446684, 178957.0, 179113.0, 23842.165524206568, 28242.717572824007, 28603.427931440838, 28879.133625991253, 28896.277593060342, 32887.342253154326, 41576.58423415727, 42169.0, 42238.044569963095, 43337.13325733531, 32955.27902195815, 33087.66912330846, 33702.49446258259, 33815.49276760801, 34005.319893602486, 33036.50445243371, 33272.83363583167, 33334.66665333316, 33343.66656333405, 33522.0, 32907.8354608235, 33287.334253314315, 33724.662753372155, 33735.662643374235, 33848.3230335387, 27851.303717406416, 29626.407471850012, 30128.849355753082, 30200.24499387445, 30345.393092138474, 23345.766542335037, 23651.0, 23979.28062158138, 24037.278881633578, 24038.87980560086], "unit": "score", "name": "ext.html", "value": 16568.349980680992}, {"lowerIsBetter": false, "replicates": [326.37987823136024, 332.9760984971213, 334.9899503014909, 335.78509753757584, 338.31153602419084, 14604.05073670212, 14847.480338188165, 15374.769378459332, 15505.844941550582, 16277.267522961465, 14354.0, 14537.273136343167, 14822.110673359606, 15379.69240615187, 15383.307751151196, 4855.781489832948, 5042.949570504285, 5044.848654540369, 5045.318881950945, 5065.189569668853, 4916.901661966758, 4967.726775027372, 4988.201887697969, 5061.519155680223, 5066.113430149728, 4983.302337672729, 4994.0261648978285, 5002.7248501332415, 5004.12427825131, 5036.798528058874, 4884.365032545782, 4977.203647416414, 4988.326575912241, 4989.57588604969, 5087.56755675768, 4867.318575399447, 4870.756462176877, 4901.828436004758, 4903.068417000758, 4907.901841963141, 11641.825372619418, 11881.227720198245, 11940.164188506807, 11959.342236177006, 12068.758624827455, 1565.3503795924678, 1647.176411794103, 1694.186790340631, 1746.7903851537897, 2020.3736841579012, 8781.20969112783, 8853.911460885372, 9168.770780730536, 9184.403013804082, 11829.0, 1720.329071662053, 1748.1521462090875, 1751.422030729856, 1783.4521473459376, 1796.514940965945, 53853.0, 55541.44458555403, 55805.0, 57306.71346643282, 57482.425175748125, 9676.838779346523, 9679.854802177973, 9688.854667179998, 9757.512124393752, 9904.504774761233, 12388.31864247457, 12486.0, 12500.124991250525, 12501.812472812915, 12514.249145051326, 6439.678016099177, 6481.449076828428, 6490.286068532458, 6579.506537009744, 6583.703733332011, 6015.729292181863, 6047.0, 6112.0, 6125.601835880653, 6134.2332208473945, 4101.733387329814, 4187.099773548702, 4191.685623578243, 4224.683148763855, 4226.281532139544, 1682.848543631079, 1735.5053809664184, 1735.947921562355, 1762.9294828206728, 1773.2552328022261, 810.4124509730516, 811.7645882694071, 813.4062134641745, 829.1749709039544, 964.9951750241204, 14986.775198372034, 15109.168995705122, 15190.46833360827, 15284.465043723416, 15546.455874044354, 812.1837553258937, 832.3050253038659, 848.5502683577714, 862.4437237981467, 898.2275243290765, 8441.36689748259, 8709.259712924346, 8711.782205444915, 8920.776980575538, 8948.821023579492, 346775.0, 348754.0, 354140.0, 354302.0, 355720.0, 58481.415185847596, 61793.38206617876, 62564.0, 64223.678881605294, 65502.67248663726, 882.3117967984982, 889.6485888074304, 893.2362829780574, 908.404994728454, 909.4270609515962, 13405.396757145756, 13656.0, 13736.351637803127, 13830.446782128602, 13928.72142557123, 28830.135095947157, 28984.855075724485, 30049.54925676073, 30308.696913030588, 30836.229094271926, 39232.411513826744, 40626.35928664627, 40671.0, 41238.58761412348, 42550.36174457324, 6899.75850845218, 7112.57324560528, 7183.0, 7190.06529151207, 7273.927260727537, 8862.689805856764, 10491.632792852213, 11002.0, 11134.3876086816, 11215.71960700989, 8890.555472226491, 9050.09499050116, 9168.633254669738, 9334.71995840126, 9494.525273736424, 9691.757706057406, 9848.212143028684, 9850.507474626384, 9853.901460985586, 10080.243981701255, 9555.952220238854, 9679.177269932135, 9934.0, 9935.801283974424, 9969.700908972742, 7118.0, 7139.357457828821, 7226.205117436973, 7236.20401755796, 7328.3404493595835, 8727.91272087271, 9073.637054517745, 9220.723378298662, 9466.95266523663, 10049.447280399649], "unit": "score", "name": "jquery.html", "value": 7429.72674503177}, {"lowerIsBetter": false, "replicates": [1079.13129930406, 1347.723716638089, 1351.1757827725082, 1453.7673972164448, 1700.7448882667597, 6191.35928978821, 6797.9320206797975, 6961.095057642512, 6988.440924726023, 6990.26602206768, 6940.201876784171, 7116.217216106224, 7144.857102857953, 7149.49953503255, 7153.141623005234, 1794.55136215946, 2076.1384025629422, 2121.7772133925946, 2125.0224896547606, 2154.062982602573, 2130.3928380411585, 2139.775323591024, 2143.3355659745453, 2143.5605700831293, 2144.035184167123, 2053.117159621362, 2086.864353816997, 2089.174775963501, 2090.9268175613856, 2092.853500254983, 2065.2461851424273, 2076.14877900061, 2085.7288552488153, 2112.9963267447993, 2139.4437446264083, 2103.7580678221893, 2117.841161912863, 2127.106615221611, 2128.1061953979365, 2128.8403369747175, 7216.3505284524645, 7260.45546584003, 7267.709291628328, 7270.818229544251, 7275.0, 4188.895277618053, 4275.893102672427, 4290.69965102443, 4293.914121717548, 4311.956880431187, 2664.5869890167055, 2699.5140874642557, 2737.9726202737916, 2741.2735625059377, 2913.2134323732475, 890.0520945193413, 896.5162655804654, 898.4923518212189, 909.1817364372052, 921.7603423109973, 9548.61805527785, 9595.90404095964, 9606.471644059575, 9635.277354198393, 9642.180414664692, 3901.141748815256, 3981.7411868228473, 4038.273110840018, 4072.3077076897, 4076.3885417187066, 8079.353651707849, 8097.433179677366, 8099.311558517592, 8117.0665373481625, 8121.390895682729, 3653.780773153619, 4289.485261768607, 4291.077418355068, 4292.527821939647, 4297.09760950204, 3791.431285307226, 3825.5600605930117, 3828.942565861514, 3846.2692088503095, 3880.3985382265796, 3281.5405843181975, 3368.9663103369144, 3387.8983630491125, 3399.6430374810784, 3428.7428442866885, 1044.7127040064042, 1057.2282233969245, 1059.0891833023593, 1064.2656566968767, 1071.1484369925927, 1084.9186311026704, 1091.5251865438559, 1095.05277934586, 1098.5441041967654, 1143.857017872766, 6695.430888374445, 6728.831779205559, 6732.831679208059, 6759.763408280686, 6774.220964589037, 1062.5909025025421, 1080.6271836216492, 1085.2511766880828, 1101.498818037791, 1112.1603189591806, 5097.949020509822, 5215.608829337815, 5249.028929648028, 5278.9472105278455, 5288.286081379041, 8538.615762290712, 8745.431546949429, 8877.911220887838, 8885.333599980027, 8893.333000025024, 8527.957360213159, 8623.0, 8696.826063478695, 8705.869411958825, 8714.782130446663, 6763.323667633197, 6910.20532638753, 6913.75801846933, 6915.343042410963, 6963.442924566022, 6340.175777148941, 6429.7428102875365, 6459.063435801876, 6460.515461340325, 6469.061986012096, 7293.161286452126, 7631.198724133886, 7684.884726728992, 7691.077230692327, 7705.383569314329, 7494.475386722877, 7689.9615501922135, 7777.105632852295, 7785.922140778746, 7790.376769858511, 5797.826065218051, 5834.94165058344, 5918.644881307136, 5939.732712027882, 5947.137665038632, 6746.628935408599, 6765.188177418741, 6780.118584583973, 6783.864322713617, 6807.285235050248, 5915.201447804491, 6096.939030609815, 6106.2061931948565, 6153.723082461211, 6292.4966002720585, 6100.633961962297, 6129.325774164749, 6134.938650613615, 6197.845053873689, 6285.057241413641, 6300.59046161998, 6339.366063393623, 6354.809355719336, 6361.936380636134, 6376.521760868046, 5723.7996670116345, 5798.391168927202, 5803.65178089316, 5824.0, 5828.854278642898, 5932.940670593239, 6028.969855150696, 6054.848628784315, 6070.332263450929, 6092.238470191226], "unit": "score", "name": "mootools.html", "value": 4089.2340248928062}, {"lowerIsBetter": false, "replicates": [289.7812151825372, 290.6178375436301, 293.2902376249476, 293.41463779759385, 294.5169921329021, 5189.221616757488, 5290.312259406282, 5290.656107353019, 5295.602829787762, 5299.390570084442, 5214.556762675177, 5278.868028299295, 5282.683039017662, 5283.947160528403, 5288.709120998344, 3860.1507668313066, 3969.8412063517426, 4032.8588499402526, 4076.449679293302, 4088.4276201331836, 4098.938515922248, 4108.219438306712, 4111.97944010281, 4114.670826333886, 4119.917601647965, 3851.4222866569958, 4073.0, 4090.6318431341174, 4091.079507110891, 4096.262672718909, 3964.980175099135, 4012.498437695288, 4020.959790402088, 4022.1754540319166, 4039.454673619053, 3566.696830769388, 3570.80360580168, 3573.1960308930543, 3576.3920133577353, 3576.8554062699945, 5066.645334826564, 5073.619478539124, 5089.058524173003, 5092.00705862357, 5097.770600322994, 4665.346851440801, 4674.135284972291, 4677.859664210045, 4682.438107427097, 4683.274092515631, 5524.751386187591, 5525.530329921921, 5529.751161197756, 5533.059379905426, 5534.252875861747, 3771.641694039062, 3877.941830872539, 3880.611938806125, 3886.24218277436, 3886.397608370707, 5797.507211886995, 5808.535317174616, 5811.476967072984, 5814.709264536757, 5830.621009634403, 3958.802059896994, 3991.7604943703473, 3993.880183594497, 3995.400689896481, 3998.800059997047, 4050.8784736457956, 4060.878173654795, 4061.939070913939, 4062.6546743527133, 4063.3701776224734, 4615.353850460938, 4632.629389648888, 4639.188142075123, 4648.930266046012, 4649.907001860011, 5503.779848806083, 5515.034868897927, 5519.227308176858, 5524.530414914697, 5531.225628412026, 1404.3118871752768, 1432.0333774702035, 1434.863687949643, 1435.612384656158, 1437.23826372023, 831.8502669519545, 872.4067634008808, 892.2371372476568, 907.5689047702289, 917.1974522292994, 4775.761211939389, 4782.856514304576, 4795.20879054959, 4801.0, 4801.279808028824, 5628.099504079328, 5702.600817942704, 5708.0, 5709.058005429058, 5716.0, 4791.089692958327, 4842.467328593852, 4866.6106711463, 4868.634852386014, 4871.464138944713, 3033.7421319187674, 3075.2004478835215, 3078.3227689908185, 3081.0910781319562, 3083.4141513112436, 5452.754626041838, 5462.0, 5498.615096943256, 5516.862078448071, 5525.0, 5689.34572524165, 5827.912581311284, 5865.266841644794, 5872.618279811884, 5874.0, 5415.458454154553, 5441.755121019563, 5445.319335083114, 5448.945510544844, 5451.509364157245, 5698.715064246689, 5709.257796486596, 5711.485966263056, 5711.857203569778, 5713.400092990176, 5561.082421400423, 5579.553635709052, 5581.413951535031, 5582.888342233214, 5586.245856809279, 5434.619576629598, 5436.619436639556, 5441.047816632153, 5450.1007333789485, 5457.045017121908, 3773.289570870252, 3833.3291673956387, 3877.825497852547, 3880.0493878998695, 3880.3403421418993, 5675.31896172462, 5696.715164241854, 5701.657900525982, 5708.828735137952, 5708.885822283614, 5496.038193316233, 5503.3120859892515, 5507.752151153128, 5512.641678290898, 5512.834614961557, 5488.1493368527945, 5497.065498865122, 5497.972510137423, 5499.312585926759, 5505.944940550704, 5341.278927344914, 5353.705546194997, 5354.7590358434745, 5360.785568577369, 5368.731563421891, 5399.892002160013, 5485.862853428696, 5548.833534993957, 5554.08357620988, 5558.249636299048, 5374.328208973879, 5401.297831281908, 5401.459854014567, 5408.972295263888, 5412.269343638716], "unit": "score", "name": "prototype.html", "value": 4134.679228304386}, {"lowerIsBetter": false, "replicates": [555.9694216818078, 560.9467100625442, 624.9999999999999, 659.3241927024799, 670.4401824476562, 10655.200859935507, 10775.784484310308, 11424.485898134582, 11741.23681960672, 11768.411579421037, 10536.36781793093, 10554.525046372912, 10752.03231709146, 11001.394923279217, 11094.0, 595.5741644724021, 746.2612014106037, 749.8687729647318, 753.758797184901, 754.1666458563291, 767.03736810303, 769.4882902869613, 774.3069952392606, 774.3804956035177, 775.11249619186, 812.8943237379162, 816.5019338203691, 816.742726041298, 817.146082343952, 817.4114637461018, 623.6538721009861, 794.7774623105539, 809.4697972827807, 809.554744890308, 811.1037303779327, 597.5787070115558, 598.2730981857064, 598.4404581716109, 598.4703537369415, 599.2030599302917, 11814.113941454425, 11843.407829608484, 11887.049036077093, 11902.34537100459, 11912.225705329125, 10249.282550221487, 11089.667309980714, 11130.38782866942, 11392.0, 11617.593384231595, 9356.90643093567, 9374.343795934288, 9432.764180895463, 9547.761305967337, 9687.515624218831, 3127.2807254331633, 3193.2655489237604, 3197.4244635965515, 3206.406814739281, 3241.9837900810344, 41632.37551436731, 41668.1666366671, 41861.790691046655, 42041.369379459335, 42079.579204207876, 7949.523028618301, 8049.356051515864, 8194.795130121676, 8267.751967440987, 8362.498250105013, 15058.698826023638, 15942.60143496422, 16388.75416868748, 16466.917665411835, 16521.91739041321, 6654.168228971379, 6740.0, 6754.45964322853, 6789.830254243683, 6798.082258895085, 3580.803055831902, 3632.4914511968345, 3672.265546890633, 3740.0649837540614, 3740.682042026458, 2643.960340594893, 2644.259607309956, 2672.198340497882, 2672.679278486594, 2683.3023413912524, 431.15923948300315, 467.4881005299192, 476.142942703133, 481.0859367202274, 484.5082241524855, 436.52418863439004, 440.6562880952862, 526.1739069660673, 533.2987121934643, 548.4323724944663, 6928.688209030505, 7213.935289093673, 7286.198518162998, 7364.742234021891, 7449.404047676173, 432.9567043295645, 477.4437779986277, 516.6564234783901, 540.0629907111158, 551.0879494436714, 3209.3741720364305, 3348.514465402503, 3399.7110245628905, 3462.532558104674, 3505.5968563615, 50692.0, 51085.0, 51456.0, 51874.48125518772, 51875.22187167196, 44531.0, 45104.548954510035, 45510.54489455063, 45678.77160614176, 45757.54242457533, 41197.38203926943, 41441.378379324335, 41575.37636935448, 41984.58015419807, 42023.57976420258, 6794.76218332356, 6850.862982740417, 6895.931040689529, 6898.310168983062, 6910.412614927787, 29500.409991799614, 30036.399272014874, 30701.692983070778, 31025.224369390944, 31296.0, 39378.60621393749, 39847.80076099601, 39986.60013399829, 40370.79814601026, 41169.1766164669, 9797.167240784613, 9966.202703783825, 9987.650432234837, 10169.694909152737, 10173.389596624227, 10619.787604248026, 10744.0, 10797.514111865143, 10810.405427701551, 10986.176036797113, 7327.303906128909, 8372.125269893048, 9574.521273936414, 9892.455914924749, 10228.590856365661, 8702.390832641655, 8873.955630221808, 8893.911060889566, 9078.773030674285, 9113.0, 9203.447793132433, 9343.0, 9355.719328420158, 9392.483413412328, 9550.235981121356, 8110.391720620859, 8283.0, 8325.748645946773, 8445.240226797823, 9040.593173307348, 7791.805204869924, 8128.14654461273, 8185.959070204849, 8228.177182281725, 8268.627911743866], "unit": "score", "name": "yui.html", "value": 5439.306182751745}], "name": "dromaeo_css", "value": 6093.291998995492}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 107.0, 113.0, 113.0, 113.0, 103.0, 115.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [153.0, 140.0, 150.0, 172.0, 134.0, 155.0, 158.0, 134.0, 175.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 159.0, 162.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 100.0, 91.0, 73.0, 74.0, 74.0, 109.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 145.0, 95.0, 95.0, 95.0, 142.0, 95.0, 94.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 68.0, 76.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.3}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 69.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 83.0, 83.0, 90.0, 83.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [119.0, 123.0, 119.0, 120.0, 130.0, 123.0, 133.0, 119.0, 139.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [146.0, 137.0, 151.0, 134.0, 150.0, 135.0, 148.0, 146.0, 152.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 74.0, 70.0, 69.0, 73.0, 72.0, 72.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1533.6000000000001}]} 18:30:46 INFO - Return code: 0 18:30:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:30:46 ERROR - # TBPL SUCCESS # 18:30:46 INFO - Running post-action listener: _resource_record_post_action 18:30:46 INFO - Running post-run listener: _resource_record_post_run 18:30:47 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364560384; Read time: 136; Write time: 409768 18:30:47 INFO - install - Wall time: 18s; CPU: 12.0%; Read bytes: 0; Write bytes: 78348288; Read time: 0; Write time: 207844 18:30:47 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280395776; Read time: 136; Write time: 189124 18:30:47 INFO - Running post-run listener: _upload_blobber_files 18:30:47 INFO - Blob upload gear active. 18:30:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:47 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 18:30:47 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'] 18:30:47 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 18:30:47 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:30:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:30:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:48 INFO - (blobuploader) - INFO - Done attempting. 18:30:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:30:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:30:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:49 INFO - (blobuploader) - INFO - Done attempting. 18:30:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:49 INFO - Return code: 0 18:30:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7986e640f8b4149c5ef4d3eb937c8447d3000e40a986941baf41a814fb051bd33e00b71b1c133c6920f1abba7864a2dff1d3730fb399cd4b24cdb95d34694c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c43865e4722ff85fbb1625d702352475c173b0a425696f0f51d649891f9d25ef43738bc7c3d47f1e6c37d9cbeb36bd2254a9feb22bb0277871247da971d8ce56"} 18:30:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:49 INFO - Contents: 18:30:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7986e640f8b4149c5ef4d3eb937c8447d3000e40a986941baf41a814fb051bd33e00b71b1c133c6920f1abba7864a2dff1d3730fb399cd4b24cdb95d34694c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c43865e4722ff85fbb1625d702352475c173b0a425696f0f51d649891f9d25ef43738bc7c3d47f1e6c37d9cbeb36bd2254a9feb22bb0277871247da971d8ce56"} 18:30:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:49 INFO - Copying logs to upload dir... 18:30:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.410983 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-03-08 18:30:48.757930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 18:30:48.762699) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 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/7986e640f8b4149c5ef4d3eb937c8447d3000e40a986941baf41a814fb051bd33e00b71b1c133c6920f1abba7864a2dff1d3730fb399cd4b24cdb95d34694c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c43865e4722ff85fbb1625d702352475c173b0a425696f0f51d649891f9d25ef43738bc7c3d47f1e6c37d9cbeb36bd2254a9feb22bb0277871247da971d8ce56"} build_url:https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/Z6neG80MQ2-telvK4cxsaQ/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/7986e640f8b4149c5ef4d3eb937c8447d3000e40a986941baf41a814fb051bd33e00b71b1c133c6920f1abba7864a2dff1d3730fb399cd4b24cdb95d34694c34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c43865e4722ff85fbb1625d702352475c173b0a425696f0f51d649891f9d25ef43738bc7c3d47f1e6c37d9cbeb36bd2254a9feb22bb0277871247da971d8ce56"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 18:30:48.792904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:30:48.793276) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457488459.317599-604810598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 18:30:48.874095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 18:30:48.877447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 18:30:48.877770) ========= ========= Total master_lag: 0.33 =========