builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1457917446.22 results: success (0) buildid: 20160313160931 builduid: b8234436d3b84c6a849d9e980d4d758e revision: f0c0480732d36153e8839c7f17394d45f679f87d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.218698) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.219151) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.219478) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006458 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.277079) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.277350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.291567) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.291837) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.342446) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.342728) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.343106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.343375) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-13 18:04:06-- 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% 96.8M=0s 2016-03-13 18:04:06 (96.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103342 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.458854) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.459126) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022056 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.508411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:06.508723) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f0c0480732d36153e8839c7f17394d45f679f87d --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 f0c0480732d36153e8839c7f17394d45f679f87d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-13 18:04:06,574 truncating revision to first 12 chars 2016-03-13 18:04:06,574 Setting DEBUG logging. 2016-03-13 18:04:06,574 attempt 1/10 2016-03-13 18:04:06,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f0c0480732d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-13 18:04:06,843 unpacking tar archive at: fx-team-f0c0480732d3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:07.078265) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:07.078559) ========= echo f0c0480732d36153e8839c7f17394d45f679f87d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f0c0480732d36153e8839c7f17394d45f679f87d'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f0c0480732d36153e8839c7f17394d45f679f87d program finished with exit code 0 elapsedTime=0.004035 script_repo_revision: 'f0c0480732d36153e8839c7f17394d45f679f87d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:07.127374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:07.127652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 18:04:07.137251) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-03-13 18:04:07.137512) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:04:07 INFO - MultiFileLogger online at 20160313 18:04:07 in /builds/slave/test 18:04:07 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:04:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:07 INFO - {'append_to_log': False, 18:04:07 INFO - 'base_work_dir': '/builds/slave/test', 18:04:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:04:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:07 INFO - 'branch': 'Fx-Team-Non-PGO', 18:04:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:07 INFO - 'config_files': ('talos/linux_config.py',), 18:04:07 INFO - 'default_actions': ('clobber', 18:04:07 INFO - 'read-buildbot-config', 18:04:07 INFO - 'download-and-extract', 18:04:07 INFO - 'populate-webroot', 18:04:07 INFO - 'create-virtualenv', 18:04:07 INFO - 'install', 18:04:07 INFO - 'run-tests'), 18:04:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:07 INFO - 'download_minidump_stackwalk': True, 18:04:07 INFO - 'download_symbols': 'ondemand', 18:04:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:04:07 INFO - 'tooltool.py': '/tools/tooltool.py', 18:04:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:04:07 INFO - '/tools/misc-python/virtualenv.py')}, 18:04:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:07 INFO - 'installer_path': 'installer.exe', 18:04:07 INFO - 'log_level': 'info', 18:04:07 INFO - 'log_name': 'talos', 18:04:07 INFO - 'log_to_console': True, 18:04:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:04:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:04:07 INFO - 'opt_config_files': (), 18:04:07 INFO - 'pip_index': False, 18:04:07 INFO - 'sps_profile': False, 18:04:07 INFO - 'sps_profile_interval': 0, 18:04:07 INFO - 'suite': 'dromaeojs', 18:04:07 INFO - 'system_bits': '32', 18:04:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:07 INFO - 'title': 'talos-linux64-ix-016', 18:04:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:07 INFO - 'use_talos_json': True, 18:04:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:07 INFO - 'work_dir': 'build'} 18:04:07 INFO - ##### 18:04:07 INFO - ##### Running clobber step. 18:04:07 INFO - ##### 18:04:07 INFO - Running pre-action listener: _resource_record_pre_action 18:04:07 INFO - Running main action method: clobber 18:04:07 INFO - rmtree: /builds/slave/test/build 18:04:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:07 INFO - Running post-action listener: _resource_record_post_action 18:04:07 INFO - ##### 18:04:07 INFO - ##### Running read-buildbot-config step. 18:04:07 INFO - ##### 18:04:07 INFO - Running pre-action listener: _resource_record_pre_action 18:04:07 INFO - Running main action method: read_buildbot_config 18:04:07 INFO - Using buildbot properties: 18:04:07 INFO - { 18:04:07 INFO - "project": "", 18:04:07 INFO - "product": "firefox", 18:04:07 INFO - "script_repo_revision": "production", 18:04:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:04:07 INFO - "repository": "", 18:04:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:04:07 INFO - "buildid": "20160313160931", 18:04:07 INFO - "pgo_build": "False", 18:04:07 INFO - "basedir": "/builds/slave/test", 18:04:07 INFO - "buildnumber": 2633, 18:04:07 INFO - "slavename": "talos-linux64-ix-016", 18:04:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:04:07 INFO - "platform": "ubuntu64_hw", 18:04:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:04:07 INFO - "branch": "fx-team", 18:04:07 INFO - "repo_path": "integration/fx-team", 18:04:07 INFO - "revision": "f0c0480732d36153e8839c7f17394d45f679f87d", 18:04:07 INFO - "stage_platform": "linux64", 18:04:07 INFO - "builduid": "b8234436d3b84c6a849d9e980d4d758e", 18:04:07 INFO - "slavebuilddir": "test" 18:04:07 INFO - } 18:04:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:04:07 INFO - Running post-action listener: _resource_record_post_action 18:04:07 INFO - ##### 18:04:07 INFO - ##### Running download-and-extract step. 18:04:07 INFO - ##### 18:04:07 INFO - Running pre-action listener: _resource_record_pre_action 18:04:07 INFO - Running main action method: download_and_extract 18:04:07 INFO - mkdir: /builds/slave/test/build/tests 18:04: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:04:07 INFO - https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:04:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:04:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:04:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:17 INFO - Downloaded 1361 bytes. 18:04:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:04:17 INFO - Using the following test package requirements: 18:04:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:04:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:04:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:04:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:17 INFO - u'jsshell-linux-x86_64.zip'], 18:04:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:04:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:04:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:04:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:04:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:04:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:04:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:04:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:04:17 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:04:17 INFO - https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:04:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:04:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:04:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:25 INFO - Downloaded 21989026 bytes. 18:04:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:04:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:04:27 INFO - Return code: 0 18:04:27 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:04: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:04:27 INFO - https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:28 INFO - Downloaded 21989026 bytes. 18:04:28 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:04:28 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:04:29 INFO - Return code: 0 18:04: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:04:29 INFO - https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:30 INFO - Downloaded 10845263 bytes. 18:04:30 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:04:30 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:04:31 INFO - Return code: 0 18:04:31 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:04:31 INFO - https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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:04:32 INFO - Downloaded 54135127 bytes. 18:04:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:04:32 INFO - mkdir: /builds/slave/test/properties 18:04:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:04:32 INFO - Writing to file /builds/slave/test/properties/build_url 18:04:32 INFO - Contents: 18:04:32 INFO - build_url:https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:04:33 INFO - Running post-action listener: _resource_record_post_action 18:04:33 INFO - Running post-action listener: set_extra_try_arguments 18:04:33 INFO - ##### 18:04:33 INFO - ##### Running populate-webroot step. 18:04:33 INFO - ##### 18:04:33 INFO - Running pre-action listener: _resource_record_pre_action 18:04:33 INFO - Running main action method: populate_webroot 18:04:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:04:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:04:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:04:33 INFO - '--tppagecycles', 18:04:33 INFO - '7'], 18:04:33 INFO - 'tests': ['tsvgm']}}, 18:04:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:04:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:04:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:04:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:04:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:33 INFO - 'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:04:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:33 INFO - 'tests': ['damp', 'tps']}, 18:04:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:33 INFO - 'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['damp', 'tps']}, 18:04:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:04:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:04:33 INFO - 'other': {'tests': ['a11yr', 18:04:33 INFO - 'ts_paint', 18:04:33 INFO - 'tpaint', 18:04:33 INFO - 'sessionrestore', 18:04:33 INFO - 'sessionrestore_no_auto_restore', 18:04:33 INFO - 'tabpaint']}, 18:04:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['a11yr', 18:04:33 INFO - 'ts_paint', 18:04:33 INFO - 'tpaint', 18:04:33 INFO - 'sessionrestore', 18:04:33 INFO - 'sessionrestore_no_auto_restore', 18:04:33 INFO - 'tabpaint']}, 18:04:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['a11yr', 18:04:33 INFO - 'ts_paint', 18:04:33 INFO - 'tpaint', 18:04:33 INFO - 'sessionrestore', 18:04:33 INFO - 'sessionrestore_no_auto_restore', 18:04:33 INFO - 'tabpaint']}, 18:04:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['a11yr', 18:04:33 INFO - 'ts_paint', 18:04:33 INFO - 'tpaint', 18:04:33 INFO - 'sessionrestore', 18:04:33 INFO - 'sessionrestore_no_auto_restore', 18:04:33 INFO - 'tabpaint']}, 18:04:33 INFO - 'other_l64': {'tests': ['a11yr', 18:04:33 INFO - 'ts_paint', 18:04:33 INFO - 'tpaint', 18:04:33 INFO - 'sessionrestore', 18:04:33 INFO - 'sessionrestore_no_auto_restore', 18:04:33 INFO - 'tabpaint']}, 18:04:33 INFO - 'other_nol64': {'tests': ['a11yr', 18:04:33 INFO - 'ts_paint', 18:04:33 INFO - 'tpaint', 18:04:33 INFO - 'sessionrestore', 18:04:33 INFO - 'sessionrestore_no_auto_restore', 18:04:33 INFO - 'tabpaint']}, 18:04:33 INFO - 'svgr': {'tests': ['tsvgx', 18:04:33 INFO - 'tsvgr_opacity', 18:04:33 INFO - 'tart', 18:04:33 INFO - 'tscrollx', 18:04:33 INFO - 'cart']}, 18:04:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['tsvgx', 18:04:33 INFO - 'tsvgr_opacity', 18:04:33 INFO - 'tart', 18:04:33 INFO - 'tscrollx', 18:04:33 INFO - 'cart']}, 18:04:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:33 INFO - 'tests': ['tp5o']}, 18:04:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:33 INFO - 'talos_options': ['--e10s'], 18:04:33 INFO - 'tests': ['tp5o']}, 18:04:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:33 INFO - 'talos_options': ['--xperf_path', 18:04:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:33 INFO - 'tests': ['tp5n']}, 18:04:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:04:33 INFO - 'talos_options': ['--e10s', 18:04:33 INFO - '--xperf_path', 18:04:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:04:33 INFO - 'tests': ['tp5n']}}, 18:04:33 INFO - 'talos.zip': {'path': '', 18:04:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:04:33 INFO - Running post-action listener: _resource_record_post_action 18:04:33 INFO - ##### 18:04:33 INFO - ##### Running create-virtualenv step. 18:04:33 INFO - ##### 18:04:33 INFO - Running pre-action listener: _resource_record_pre_action 18:04:33 INFO - Running main action method: create_virtualenv 18:04:33 INFO - Creating virtualenv /builds/slave/test/build/venv 18:04:33 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:04:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:04:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:04:33 INFO - Using real prefix '/usr' 18:04:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:04:33 INFO - Installing distribute.............................................................................................................................................................................................done. 18:04:35 INFO - Installing pip.................done. 18:04:35 INFO - Return code: 0 18:04:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:04: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:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04: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:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:35 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 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:35 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:04:35 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:04:35 INFO - Using env: {'DISPLAY': ':0', 18:04:35 INFO - 'HOME': '/home/cltbld', 18:04:35 INFO - 'LANG': 'en_US.UTF-8', 18:04:35 INFO - 'LANGUAGE': 'en_US:en', 18:04:35 INFO - 'LOGNAME': 'cltbld', 18:04:35 INFO - 'MAIL': '/var/mail/cltbld', 18:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:35 INFO - 'MOZ_NO_REMOTE': '1', 18:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:35 INFO - 'NO_EM_RESTART': '1', 18:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:35 INFO - 'PWD': '/builds/slave/test', 18:04:35 INFO - 'SHELL': '/bin/bash', 18:04:35 INFO - 'SHLVL': '1', 18:04:35 INFO - 'TERM': 'linux', 18:04:35 INFO - 'TMOUT': '86400', 18:04:35 INFO - 'USER': 'cltbld', 18:04:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:35 INFO - '_': '/tools/buildbot/bin/python'} 18:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:35 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:04:35 INFO - Cleaning up... 18:04:35 INFO - Return code: 0 18:04:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:04: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:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04: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:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:35 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 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:35 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:04:35 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:04:35 INFO - Using env: {'DISPLAY': ':0', 18:04:35 INFO - 'HOME': '/home/cltbld', 18:04:35 INFO - 'LANG': 'en_US.UTF-8', 18:04:35 INFO - 'LANGUAGE': 'en_US:en', 18:04:35 INFO - 'LOGNAME': 'cltbld', 18:04:35 INFO - 'MAIL': '/var/mail/cltbld', 18:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:35 INFO - 'MOZ_NO_REMOTE': '1', 18:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:35 INFO - 'NO_EM_RESTART': '1', 18:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:35 INFO - 'PWD': '/builds/slave/test', 18:04:35 INFO - 'SHELL': '/bin/bash', 18:04:35 INFO - 'SHLVL': '1', 18:04:35 INFO - 'TERM': 'linux', 18:04:35 INFO - 'TMOUT': '86400', 18:04:35 INFO - 'USER': 'cltbld', 18:04:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:35 INFO - '_': '/tools/buildbot/bin/python'} 18:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:36 INFO - Downloading/unpacking psutil>=0.7.1 18:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:04:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:38 INFO - Installing collected packages: psutil 18:04:38 INFO - Running setup.py install for psutil 18:04:38 INFO - building 'psutil._psutil_linux' extension 18:04:38 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:04:38 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:04:38 INFO - building 'psutil._psutil_posix' extension 18:04:38 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:04:38 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:04:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:04:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:04:38 INFO - Successfully installed psutil 18:04:38 INFO - Cleaning up... 18:04:38 INFO - Return code: 0 18:04:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:04:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:04:38 INFO - Using env: {'DISPLAY': ':0', 18:04:38 INFO - 'HOME': '/home/cltbld', 18:04:38 INFO - 'LANG': 'en_US.UTF-8', 18:04:38 INFO - 'LANGUAGE': 'en_US:en', 18:04:38 INFO - 'LOGNAME': 'cltbld', 18:04:38 INFO - 'MAIL': '/var/mail/cltbld', 18:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:38 INFO - 'MOZ_NO_REMOTE': '1', 18:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:38 INFO - 'NO_EM_RESTART': '1', 18:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:38 INFO - 'PWD': '/builds/slave/test', 18:04:38 INFO - 'SHELL': '/bin/bash', 18:04:38 INFO - 'SHLVL': '1', 18:04:38 INFO - 'TERM': 'linux', 18:04:38 INFO - 'TMOUT': '86400', 18:04:38 INFO - 'USER': 'cltbld', 18:04:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:38 INFO - '_': '/tools/buildbot/bin/python'} 18:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:04:38 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:04:38 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:04:38 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:04:38 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:04:38 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:04:38 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:04:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:04:40 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:04:40 INFO - Installing collected packages: mozsystemmonitor 18:04:40 INFO - Running setup.py install for mozsystemmonitor 18:04:40 INFO - Successfully installed mozsystemmonitor 18:04:40 INFO - Cleaning up... 18:04:40 INFO - Return code: 0 18:04:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:04:40 INFO - Using env: {'DISPLAY': ':0', 18:04:40 INFO - 'HOME': '/home/cltbld', 18:04:40 INFO - 'LANG': 'en_US.UTF-8', 18:04:40 INFO - 'LANGUAGE': 'en_US:en', 18:04:40 INFO - 'LOGNAME': 'cltbld', 18:04:40 INFO - 'MAIL': '/var/mail/cltbld', 18:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:40 INFO - 'MOZ_NO_REMOTE': '1', 18:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:40 INFO - 'NO_EM_RESTART': '1', 18:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:40 INFO - 'PWD': '/builds/slave/test', 18:04:40 INFO - 'SHELL': '/bin/bash', 18:04:40 INFO - 'SHLVL': '1', 18:04:40 INFO - 'TERM': 'linux', 18:04:40 INFO - 'TMOUT': '86400', 18:04:40 INFO - 'USER': 'cltbld', 18:04:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:40 INFO - '_': '/tools/buildbot/bin/python'} 18:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:41 INFO - Downloading/unpacking blobuploader==1.2.4 18:04: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:04: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:04: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:04: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:04: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:04: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:04:42 INFO - Downloading blobuploader-1.2.4.tar.gz 18:04:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:04:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:04: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:04: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:04: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:04: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:04: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:04: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:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:04:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:04:43 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:04:43 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:04:43 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:04:43 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:04:43 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:04:43 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:04:43 INFO - Downloading docopt-0.6.1.tar.gz 18:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:04:43 INFO - Installing collected packages: blobuploader, requests, docopt 18:04:43 INFO - Running setup.py install for blobuploader 18:04:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:04:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:04:43 INFO - Running setup.py install for requests 18:04:44 INFO - Running setup.py install for docopt 18:04:44 INFO - Successfully installed blobuploader requests docopt 18:04:44 INFO - Cleaning up... 18:04:44 INFO - Return code: 0 18:04:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:44 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 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:44 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:04:44 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:04:44 INFO - Using env: {'DISPLAY': ':0', 18:04:44 INFO - 'HOME': '/home/cltbld', 18:04:44 INFO - 'LANG': 'en_US.UTF-8', 18:04:44 INFO - 'LANGUAGE': 'en_US:en', 18:04:44 INFO - 'LOGNAME': 'cltbld', 18:04:44 INFO - 'MAIL': '/var/mail/cltbld', 18:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:44 INFO - 'MOZ_NO_REMOTE': '1', 18:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:44 INFO - 'NO_EM_RESTART': '1', 18:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:44 INFO - 'PWD': '/builds/slave/test', 18:04:44 INFO - 'SHELL': '/bin/bash', 18:04:44 INFO - 'SHLVL': '1', 18:04:44 INFO - 'TERM': 'linux', 18:04:44 INFO - 'TMOUT': '86400', 18:04:44 INFO - 'USER': 'cltbld', 18:04:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:44 INFO - '_': '/tools/buildbot/bin/python'} 18:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:44 INFO - Running setup.py (path:/tmp/pip-6A75Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:44 INFO - Running setup.py (path:/tmp/pip-jEtWNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:44 INFO - Running setup.py (path:/tmp/pip-lYDxj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:44 INFO - Running setup.py (path:/tmp/pip-FgC_E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:44 INFO - Running setup.py (path:/tmp/pip-T8A03f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:44 INFO - Running setup.py (path:/tmp/pip-UsfqCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:44 INFO - Running setup.py (path:/tmp/pip-ovAaFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:44 INFO - Running setup.py (path:/tmp/pip-lC1wKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:44 INFO - Running setup.py (path:/tmp/pip-QAcw7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:45 INFO - Running setup.py (path:/tmp/pip-DZeYpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:45 INFO - Running setup.py (path:/tmp/pip-koJDVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:04:45 INFO - Running setup.py (path:/tmp/pip-yWqm79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:04:45 INFO - Running setup.py (path:/tmp/pip-PNDAcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:04:45 INFO - Running setup.py (path:/tmp/pip-EeTThX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:45 INFO - Running setup.py (path:/tmp/pip-E7Jbl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:04:45 INFO - Running setup.py (path:/tmp/pip-coMhxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:04:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:04:45 INFO - Running setup.py (path:/tmp/pip-mRDEc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:04:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:04:45 INFO - Running setup.py install for manifestparser 18:04:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:04:45 INFO - Running setup.py install for mozcrash 18:04:45 INFO - Running setup.py install for mozdebug 18:04:45 INFO - Running setup.py install for mozdevice 18:04:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Running setup.py install for mozfile 18:04:46 INFO - Running setup.py install for mozhttpd 18:04:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Running setup.py install for mozinfo 18:04:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Running setup.py install for mozInstall 18:04:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Running setup.py install for mozleak 18:04:46 INFO - Running setup.py install for mozlog 18:04:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Running setup.py install for moznetwork 18:04:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Running setup.py install for mozprocess 18:04:46 INFO - Running setup.py install for mozprofile 18:04:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:04:46 INFO - Running setup.py install for mozrunner 18:04:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:04:47 INFO - Running setup.py install for mozscreenshot 18:04:47 INFO - Running setup.py install for moztest 18:04:47 INFO - Running setup.py install for mozversion 18:04:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:04:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:04:47 INFO - Cleaning up... 18:04:47 INFO - Return code: 0 18:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:47 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:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:47 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:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:47 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 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:47 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:04:47 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:04:47 INFO - Using env: {'DISPLAY': ':0', 18:04:47 INFO - 'HOME': '/home/cltbld', 18:04:47 INFO - 'LANG': 'en_US.UTF-8', 18:04:47 INFO - 'LANGUAGE': 'en_US:en', 18:04:47 INFO - 'LOGNAME': 'cltbld', 18:04:47 INFO - 'MAIL': '/var/mail/cltbld', 18:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:47 INFO - 'MOZ_NO_REMOTE': '1', 18:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:47 INFO - 'NO_EM_RESTART': '1', 18:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:47 INFO - 'PWD': '/builds/slave/test', 18:04:47 INFO - 'SHELL': '/bin/bash', 18:04:47 INFO - 'SHLVL': '1', 18:04:47 INFO - 'TERM': 'linux', 18:04:47 INFO - 'TMOUT': '86400', 18:04:47 INFO - 'USER': 'cltbld', 18:04:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:47 INFO - '_': '/tools/buildbot/bin/python'} 18:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:47 INFO - Running setup.py (path:/tmp/pip-B3cUVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:47 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:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:47 INFO - Running setup.py (path:/tmp/pip-gRV2MJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:47 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:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:47 INFO - Running setup.py (path:/tmp/pip-hPnUFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:47 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:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:47 INFO - Running setup.py (path:/tmp/pip-MaO3en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:47 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:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:47 INFO - Running setup.py (path:/tmp/pip-AuGoug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:47 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:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:47 INFO - Running setup.py (path:/tmp/pip-a3oxfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:48 INFO - Running setup.py (path:/tmp/pip-JSwf3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:48 INFO - Running setup.py (path:/tmp/pip-oGl1sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:48 INFO - Running setup.py (path:/tmp/pip-SfswQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:48 INFO - Running setup.py (path:/tmp/pip-GFbE40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:48 INFO - Running setup.py (path:/tmp/pip-QxiMGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:04:48 INFO - Running setup.py (path:/tmp/pip-YymBc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:04:48 INFO - Running setup.py (path:/tmp/pip-Q_aVnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:04:48 INFO - Running setup.py (path:/tmp/pip-LFiZsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:48 INFO - Running setup.py (path:/tmp/pip-vejRUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:04:48 INFO - Running setup.py (path:/tmp/pip-BM5UHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:04:48 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:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:04:48 INFO - Running setup.py (path:/tmp/pip-fOLEnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:48 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:04:50 INFO - Downloading blessings-1.6.tar.gz 18:04:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:04:50 INFO - Installing collected packages: blessings 18:04:50 INFO - Running setup.py install for blessings 18:04:50 INFO - Successfully installed blessings 18:04:50 INFO - Cleaning up... 18:04:50 INFO - Return code: 0 18:04:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:04:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:04:51 INFO - Reading from file tmpfile_stdout 18:04:51 INFO - Current package versions: 18:04:51 INFO - argparse == 1.2.1 18:04:51 INFO - blessings == 1.6 18:04:51 INFO - blobuploader == 1.2.4 18:04:51 INFO - docopt == 0.6.1 18:04:51 INFO - manifestparser == 1.1 18:04:51 INFO - mozInstall == 1.12 18:04:51 INFO - mozcrash == 0.17 18:04:51 INFO - mozdebug == 0.1 18:04:51 INFO - mozdevice == 0.48 18:04:51 INFO - mozfile == 1.2 18:04:51 INFO - mozhttpd == 0.7 18:04:51 INFO - mozinfo == 0.9 18:04:51 INFO - mozleak == 0.1 18:04:51 INFO - mozlog == 3.1 18:04:51 INFO - moznetwork == 0.27 18:04:51 INFO - mozprocess == 0.22 18:04:51 INFO - mozprofile == 0.28 18:04:51 INFO - mozrunner == 6.11 18:04:51 INFO - mozscreenshot == 0.1 18:04:51 INFO - mozsystemmonitor == 0.0 18:04:51 INFO - moztest == 0.7 18:04:51 INFO - mozversion == 1.4 18:04:51 INFO - psutil == 3.1.1 18:04:51 INFO - requests == 1.2.3 18:04:51 INFO - wsgiref == 0.1.2 18:04:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:51 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 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:51 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:04:51 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:04:51 INFO - Using env: {'DISPLAY': ':0', 18:04:51 INFO - 'HOME': '/home/cltbld', 18:04:51 INFO - 'LANG': 'en_US.UTF-8', 18:04:51 INFO - 'LANGUAGE': 'en_US:en', 18:04:51 INFO - 'LOGNAME': 'cltbld', 18:04:51 INFO - 'MAIL': '/var/mail/cltbld', 18:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:51 INFO - 'MOZ_NO_REMOTE': '1', 18:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:51 INFO - 'NO_EM_RESTART': '1', 18:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:51 INFO - 'PWD': '/builds/slave/test', 18:04:51 INFO - 'SHELL': '/bin/bash', 18:04:51 INFO - 'SHLVL': '1', 18:04:51 INFO - 'TERM': 'linux', 18:04:51 INFO - 'TMOUT': '86400', 18:04:51 INFO - 'USER': 'cltbld', 18:04:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:51 INFO - '_': '/tools/buildbot/bin/python'} 18:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:51 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:04:51 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:04:51 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:04:51 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:04:51 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:04:51 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:04:51 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:04:51 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:04:51 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:04:51 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:04:51 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:04:51 INFO - Cleaning up... 18:04:51 INFO - Return code: 0 18:04:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:04:51 INFO - Using env: {'DISPLAY': ':0', 18:04:51 INFO - 'HOME': '/home/cltbld', 18:04:51 INFO - 'LANG': 'en_US.UTF-8', 18:04:51 INFO - 'LANGUAGE': 'en_US:en', 18:04:51 INFO - 'LOGNAME': 'cltbld', 18:04:51 INFO - 'MAIL': '/var/mail/cltbld', 18:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:51 INFO - 'MOZ_NO_REMOTE': '1', 18:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:51 INFO - 'NO_EM_RESTART': '1', 18:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:51 INFO - 'PWD': '/builds/slave/test', 18:04:51 INFO - 'SHELL': '/bin/bash', 18:04:51 INFO - 'SHLVL': '1', 18:04:51 INFO - 'TERM': 'linux', 18:04:51 INFO - 'TMOUT': '86400', 18:04:51 INFO - 'USER': 'cltbld', 18:04:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:51 INFO - '_': '/tools/buildbot/bin/python'} 18:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:51 INFO - Downloading/unpacking jsonschema 18:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:04:53 INFO - Downloading/unpacking functools32 (from jsonschema) 18:04:53 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:04:53 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:04:53 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:04:53 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:04:53 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:04:53 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:04:53 INFO - Downloading functools32-3.2.3-2.tar.gz 18:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:04:53 INFO - warning: no files found matching '*.txt' 18:04:53 INFO - no previously-included directories found matching 'build' 18:04:53 INFO - no previously-included directories found matching 'dist' 18:04:53 INFO - no previously-included directories found matching '.git*' 18:04:53 INFO - Installing collected packages: jsonschema, functools32 18:04:53 INFO - Running setup.py install for functools32 18:04:53 INFO - warning: no files found matching '*.txt' 18:04:53 INFO - no previously-included directories found matching 'build' 18:04:53 INFO - no previously-included directories found matching 'dist' 18:04:53 INFO - no previously-included directories found matching '.git*' 18:04:53 INFO - Successfully installed jsonschema functools32 18:04:53 INFO - Cleaning up... 18:04:53 INFO - Return code: 0 18:04:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8fe446f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122b410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', '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:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:04:53 INFO - Using env: {'DISPLAY': ':0', 18:04:53 INFO - 'HOME': '/home/cltbld', 18:04:53 INFO - 'LANG': 'en_US.UTF-8', 18:04:53 INFO - 'LANGUAGE': 'en_US:en', 18:04:53 INFO - 'LOGNAME': 'cltbld', 18:04:53 INFO - 'MAIL': '/var/mail/cltbld', 18:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:53 INFO - 'MOZ_NO_REMOTE': '1', 18:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:53 INFO - 'NO_EM_RESTART': '1', 18:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:53 INFO - 'PWD': '/builds/slave/test', 18:04:53 INFO - 'SHELL': '/bin/bash', 18:04:53 INFO - 'SHLVL': '1', 18:04:53 INFO - 'TERM': 'linux', 18:04:53 INFO - 'TMOUT': '86400', 18:04:53 INFO - 'USER': 'cltbld', 18:04:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:53 INFO - '_': '/tools/buildbot/bin/python'} 18:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:54 INFO - Downloading/unpacking flake8 18:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:04:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:04:55 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:04:55 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:04:55 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:04:55 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:04:55 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:04:55 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:04:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:04:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:04:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:04:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:04:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:04:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:04:56 INFO - no previously-included directories found matching 'docs/_build' 18:04:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:04:56 INFO - Running setup.py install for pep8 18:04:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:04:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:04:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:04:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:04:56 INFO - no previously-included directories found matching 'docs/_build' 18:04:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:04:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:04:56 INFO - Cleaning up... 18:04:56 INFO - Return code: 0 18:04:56 INFO - Running post-action listener: _resource_record_post_action 18:04:56 INFO - Running post-action listener: _start_resource_monitoring 18:04:56 INFO - Starting resource monitoring. 18:04:56 INFO - ##### 18:04:56 INFO - ##### Running install step. 18:04:56 INFO - ##### 18:04:56 INFO - Running pre-action listener: _resource_record_pre_action 18:04:56 INFO - Running main action method: install 18:04:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:04:57 INFO - Reading from file tmpfile_stdout 18:04:57 INFO - Detecting whether we're running mozinstall >=1.0... 18:04:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:04:57 INFO - Reading from file tmpfile_stdout 18:04:57 INFO - Output received: 18:04:57 INFO - Usage: mozinstall [options] installer 18:04:57 INFO - Options: 18:04:57 INFO - -h, --help show this help message and exit 18:04:57 INFO - -d DEST, --destination=DEST 18:04:57 INFO - Directory to install application into. [default: 18:04:57 INFO - "/builds/slave/test"] 18:04:57 INFO - --app=APP Application being installed. [default: firefox] 18:04:57 INFO - mkdir: /builds/slave/test/build/application 18:04:57 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:04:57 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:05:12 INFO - Reading from file tmpfile_stdout 18:05:12 INFO - Output received: 18:05:12 INFO - /builds/slave/test/build/application/firefox/firefox 18:05:12 INFO - Running post-action listener: _resource_record_post_action 18:05:12 INFO - ##### 18:05:12 INFO - ##### Running run-tests step. 18:05:12 INFO - ##### 18:05:12 INFO - Running pre-action listener: _resource_record_pre_action 18:05:12 INFO - Running main action method: run_tests 18:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:05:12 INFO - Python 2.7.3 18:05:12 INFO - Return code: 0 18:05:12 INFO - grabbing minidump binary from tooltool 18:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:05:12 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 0x12ba160>, '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 0x12bb060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bb4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:05:12 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:05:12 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:05:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:05:12 INFO - Return code: 0 18:05:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:05:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:05:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:05:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:05:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:05:13 INFO - Return code: 0 18:05:13 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/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:05:13 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/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:05:13 INFO - Using env: {'DISPLAY': ':0', 18:05:13 INFO - 'HOME': '/home/cltbld', 18:05:13 INFO - 'LANG': 'en_US.UTF-8', 18:05:13 INFO - 'LANGUAGE': 'en_US:en', 18:05:13 INFO - 'LOGNAME': 'cltbld', 18:05:13 INFO - 'MAIL': '/var/mail/cltbld', 18:05:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:05:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:13 INFO - 'MOZ_NO_REMOTE': '1', 18:05:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:05:13 INFO - 'NO_EM_RESTART': '1', 18:05:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:13 INFO - 'PWD': '/builds/slave/test', 18:05:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:05:13 INFO - 'SHELL': '/bin/bash', 18:05:13 INFO - 'SHLVL': '1', 18:05:13 INFO - 'TERM': 'linux', 18:05:13 INFO - 'TMOUT': '86400', 18:05:13 INFO - 'USER': 'cltbld', 18:05:13 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996', 18:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:13 INFO - '_': '/tools/buildbot/bin/python'} 18:05:13 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/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:05:13 INFO - mozversion application_buildid: 20160313160931 18:05:13 INFO - mozversion application_changeset: f0c0480732d36153e8839c7f17394d45f679f87d 18:05:13 INFO - mozversion application_display_name: Nightly 18:05:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:05:13 INFO - mozversion application_name: Firefox 18:05:13 INFO - mozversion application_remotingname: firefox 18:05:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:05:13 INFO - mozversion application_vendor: Mozilla 18:05:13 INFO - mozversion application_version: 48.0a1 18:05:13 INFO - mozversion platform_buildid: 20160313160931 18:05:13 INFO - mozversion platform_changeset: f0c0480732d36153e8839c7f17394d45f679f87d 18:05:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:05:13 INFO - mozversion platform_version: 48.0a1 18:05:13 INFO - using testdate: 1457917513 18:05:13 INFO - actual date: 1457917513 18:05:13 INFO - starting webserver on 'localhost:57566' 18:05:13 INFO - SUITE-START | Running 2 tests 18:05:13 INFO - TEST-START | dromaeo_css 18:05:13 INFO - operating with platform_type : linux_ 18:05:13 INFO - Initialising browser for dromaeo_css test... 18:05:13 INFO - TEST-INFO | started process 9162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ap3J_/profile http://localhost:57566/getInfo.html) 18:05:18 INFO - PROCESS | 9162 | __metrics Screen width/height:1600/1200 18:05:18 INFO - PROCESS | 9162 | colorDepth:24 18:05:18 INFO - PROCESS | 9162 | Browser inner width/height: 1024/697 18:05:18 INFO - PROCESS | 9162 | __metrics 18:05:19 ERROR - PROCESS | 9162 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:05:20 INFO - TEST-INFO | 9162: exit 0 18:05:20 INFO - Browser initialized. 18:05:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:05:20 INFO - TEST-INFO | started process 9258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ap3J_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:05:32 INFO - PROCESS | 9258 | RSS: Main: 154329088 18:05:32 INFO - PROCESS | 9258 | 18:06:23 INFO - PROCESS | 9258 | 1457917583277 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:08:34 INFO - PROCESS | 9258 | Cycle 1(1): loaded http://localhost:57566/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57566/tests/dromaeo/cssquery-ext.html) 18:08:35 INFO - PROCESS | 9258 | RSS: Main: 241258496 18:08:35 INFO - PROCESS | 9258 | 18:11:37 INFO - PROCESS | 9258 | Cycle 1(1): loaded http://localhost:57566/tests/dromaeo/cssquery-ext.html (next: http://localhost:57566/tests/dromaeo/cssquery-jquery.html) 18:11:38 INFO - PROCESS | 9258 | RSS: Main: 237305856 18:11:38 INFO - PROCESS | 9258 | 18:14:40 INFO - PROCESS | 9258 | Cycle 1(1): loaded http://localhost:57566/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57566/tests/dromaeo/cssquery-mootools.html) 18:14:40 INFO - PROCESS | 9258 | RSS: Main: 223965184 18:14:40 INFO - PROCESS | 9258 | 18:17:42 INFO - PROCESS | 9258 | Cycle 1(1): loaded http://localhost:57566/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57566/tests/dromaeo/cssquery-prototype.html) 18:17:43 INFO - PROCESS | 9258 | RSS: Main: 203583488 18:17:43 INFO - PROCESS | 9258 | 18:20:45 INFO - PROCESS | 9258 | Cycle 1(1): loaded http://localhost:57566/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57566/tests/dromaeo/cssquery-yui.html) 18:20:46 INFO - PROCESS | 9258 | RSS: Main: 202690560 18:20:46 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | Cycle 1(1): loaded http://localhost:57566/tests/dromaeo/cssquery-yui.html (next: http://localhost:57566/tests/dromaeo/cssquery-dojo.html) 18:23:49 INFO - PROCESS | 9258 | RSS: Main: 270565376 18:23:49 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | __start_tp_report 18:23:49 INFO - PROCESS | 9258 | _x_x_mozilla_page_load 18:23:49 INFO - PROCESS | 9258 | _x_x_mozilla_page_load_details 18:23:49 INFO - PROCESS | 9258 | |i|pagename|runs| 18:23:49 INFO - PROCESS | 9258 | |0;dojo.html;2568.6275490053945;2640.6303117563557;2657.0700254910785;2660.3615132368236;2690.179495253947;4526.981429178441;4557.202489564322;4563.292689633108;4569.977150114249;4663.766811659412;4575.107853968478;4598.2872654738485;4611.423572053493;4613.538646135385;4613.746243956581;4141.151064031881;4211.305134652786;4289.935650965238;4325.048489332342;4330.545292744248;4146.8133933972895;4237.364395340693;4286.57134286572;4303.720258183208;4305.763183024932;4187.057911969813;4225.281702110648;4235.470566179228;4260.616544511009;4268.295731204347;4205.990562265065;4230;4236.364545318227;4237.724547904407;4274.529801721808;4074.5925407459313;4123.9175216495805;4203.810828512725;4207.284761590507;4264.381664658638;4435.379046933432;4469.351943968139;4522.3216517522305;4528.705634133804;4531.886702832423;4890.877728056791;4912.533309335608;4914.140025495524;4915.238138088602;4962.578180854632;4819.975900120512;4916.975415122902;4923.926141107886;4937.21004639256;4974.054929563371;4559.065391594749;4577.8397756078375;4599.586037256596;4627.444706635191;4645.233536466445;5013.147764879979;5029.346184995927;5040.873978150576;5052.191649336089;5055.368078990126;4695.436547614308;4809.062232864628;4835.419749630067;4837.080954618682;4857.781399837016;4929.926051109236;4946.431160416526;4948.925766113512;4974.303597496353;5003.574696150795;4894.045661096124;4908.288298196741;4910.828121015818;4916.803327866845;4954.9009019819405;4838.637102217277;4872.19608764557;4896.5837903777865;4927.063857866994;4939.456659767423;4146;4154.896127596774;4157.189348077157;4181.414601955728;4184.8744537663915;3663.2124093320062;3672.265546890633;3680.0063982724514;3693.2059607184583;3714.1643130295465;4254.787260636956;4286.057067445157;4331.068820203608;4337.82648694055;4347.217500849814;4899.559039686445;4914.410270767531;4916.975415122973;4922.237053256751;4965.180745177077;4303.440552728188;4304.504981927056;4304.82780688769;4348.608625223745;4349.26062569364;4339.305711086274;4432.180046691373;4433.7118087324225;4486.820527178941;4513.11994161142;4702.576768090888;4715.81136754526;4738.502457242078;4739.123262196505;4782.641301902441;4948.05986862495;4974.676646017997;4978.775955082103;4980.551750342486;5030.144875371123;4624.28323609841;4645;4692.225782745809;4700.482946875909;4739.075880203327;4846.345743324606;4847.030593881167;4864.318995340726;4874;4916.164252077084;4854.101991131652;4932.062908047459;4948.134076536519;4948.628852836124;4997.675151115166;4780.521947805191;4804.375431193923;4813.181759100891;4827.517248275144;4856.635752318661;4755.690880092783;4788.3056956741775;4792;4798.616110711205;4848.878778030577;4688.390509233778;4721.433427988663;4736.289556566542;4739.739314337745;4788.976055119702;4803.03939212152;4823.1800593899825;4823.397075365579;4830.903381932412;4876.512348765095;4710.387649605529;4714.504976977368;4719.716816990992;4726.480087190337;4764.76176191196 18:23:49 INFO - PROCESS | 9258 | |1;ext.html;515.7060475528948;520.0509070945524;538.6552606331951;546.3143754587993;557.7796770275742;27580.724192758065;28069.438611227764;28164.15507534772;28172.154835354948;36036;39118.41322380167;39552;39583.60416395835;39598.208035839336;39679.80160099195;7550.395968322521;7727.8794574786625;7728.459007869451;7729.072511298652;7734.8453030939345;6737.225219099792;6800.1159849219775;6807.659617019154;6811.965940170317;6814.080099186596;6889.483288753364;6947.201071876723;6951.58290502569;6962.89555656663;6964.965175174142;6943.548669336477;6947.89578156328;6949.722011119549;6957.47818913581;7013.544119632233;7759.844803103906;7884.921150788476;7885.329746971457;7887.487313324616;7891.6054197289905;39731.20537589261;40119.19761604781;40167.7991610043;40238.396424053666;40282.39576406356;3202.407554602383;3306.947582636288;3307.9007629771145;3406.148462884279;3625.546806649169;29532.409351812843;29641.703582964325;29770.85114574435;30145.849270753504;30702.692973070207;3429.605595356516;3466.0814884055744;3478.130467383154;3482.5995010573856;3588.049166970755;237209;239683;239756;240072;240324;43734.343984840256;44170;57802.42197578055;59073;59140.40859591435;41696.79151604223;41778;41820;41836.163276734296;41879;14554.636134096732;15021.549353519413;15040.548783536511;15053;15053.849461505244;11660.708482288012;11748.118891083202;11765.058795296356;11804;11809.350485723196;15020.09879407239;15202.315895784715;15302.846971530142;15321.157336346385;15408.845911540966;5827.096799996008;5964.761409543657;5998.880022399615;6040.546958978094;6047.909281360783;810.4003037752021;848.5036253791478;884.7478468636408;947.6446332625266;963.349738926222;26880.193594192206;27943.72056279452;28419.28951776181;28433.57349639757;28485;987.3236832769576;1001.1940387987594;1006.4615430744662;1035.4253389368973;1075.3010543147018;14198.85801141996;14686;14779.556613301618;14812.058795807043;14982.250887455584;302301;305716;305824;306603;306664;47466;48183.27725084127;48497;48528;48623.5137648619;993.4734590666958;1153.1063425845036;1226.8834460726216;1227;1324.1922427319134;24190.669513176945;27941.441171176055;27982.72017279801;28158.43683126285;28428.57357139603;39363;39395.21209575735;39716;39735.20529589334;39763.22249386304;207183;209017;209037;210316;210644;26705.866470667523;31039.224019399695;31438.685613143574;31479;32451.18872028218;36036;36174.8191259042;36595.45106823453;36704.449433257985;37183.44224836684;31503.52744708877;31521.8423907879;31840.681593184698;31913.36173276568;31939.36121277608;31194.532082018333;33927;34106.65893341035;34190.658093418744;34670.479942800375;33404.49893251555;34073.82963085169;34221.31557368889;34375.48436773501;34526.82736586301;30432.239194020327;30818;30825.845870770503;31097;31146;23756.45583037097;24580.754192457847;24596.508069838146;25840.8707956459;26088.86955565286 18:23:49 INFO - PROCESS | 9258 | |2;jquery.html;362.717080677072;363.1918980268902;368.1312103435891;375.24201113750223;376.4447440025964;15413.614659633515;15967.201639918016;16661.08364039979;16956.0674162921;16987.23557439915;15886.285117169726;16150.111743854084;16484.42304519342;16494.505164845075;16497.587560311;5043.470435604264;5197.532222100011;5239.449857764937;6012.96993515034;6014;5926.585139040269;5955.136505206742;5956.523478121761;5958.940410595882;5988.790392336269;5864.882702345951;5936.465718085371;5936.7328470218945;5938.990371636832;5940.138679891435;5736.196932429463;5904.055351143839;5908.911366329508;5913.586048976574;5916.26046744157;5134.897302053938;5252.185911183773;5278.736063196825;5278.815241466568;5312.787488500456;18984.240630374767;19635.31276405319;19779.604407911906;20144.59710805776;20198.899005505027;1879.5864909719976;1885.7454243677066;1987.9701804472945;2037.4702577330002;2366.7988221001237;12456.81314780279;12816.35918204086;13050.412731427108;13366.86633133666;13555.525556605471;1732.2205007746438;1743.2591148761726;1747.3796802135187;1754.0528114817982;1772.5745821002865;42389.788051059855;52586.211206831926;53489.465105348834;58329;60955.69522152361;9507;9655.710328690151;9775.85336219943;9850.162736167505;9866.851997220047;11101.777964440827;11478.598249061242;11866.228695134789;12370.319632420124;12395.876041239471;6750.966245168743;6877.793666189922;7020.508564400545;7160.248173941765;7196.388306993859;6717.832054198587;6734.595924244561;6812.6934287957165;6859.9314006860295;6907.412869906114;5925.459380561085;5995.550333724988;6047.697615119227;6067;6074.058520929263;1710.187660861106;1720.7590937268792;1722.5607470095047;1732.1252767352657;1749.212854215608;876.4434584039182;948.0850978805486;963.6530848894392;978.858065580501;986.9654562090292;16206.513804585882;16298.185090745415;16454.670906581803;16516.50450486487;16889.493315200565;878.5607196401799;879.8108406692592;897.4794619120894;948.5778828421425;977.5503268496429;9718.951405242928;9727;9898.257630677728;9909.65316213929;10033.698989030341;391825;394102;394167;436288;448764;52471.475285246655;62205.37794621996;62739;63518.682406588596;63885.36114638794;984.8670429491926;987.4026214140629;1000.8548760429696;1003.117256813999;1003.3177439341172;14649;14712.77930831017;15051;15052.3226454812;15237.771433428286;23208.419789504722;29014.419711605227;29081.563776543793;31483.37033259276;32499.512507311938;34036.319273613895;34557;35329.47005794864;35956.101097472776;36075;6983.615901125284;7091.11361079865;7099.183593886769;7221.855562888818;7311.305425984523;10697.304675196086;11381.260218085798;11433.885661143282;11443.713907152387;11482.885171148182;9437.339386243171;9501.382410143318;9573.32986690925;9583.664571739955;10100.393976361442;9302;9429;9544.570494327632;9709.36889102206;10270.897291026995;9154.496502692416;9411.529423528933;9495.43027418357;9550.904490955001;9657.951710241685;6999.12510936133;10261.179105671677;10312.690619281433;10690.73273168177;11020.559177633126;8992.235659968976;9488.240940724587;10107.090361867467;10666.773321068176;10830.40432776205 18:23:49 INFO - PROCESS | 9258 | |3;mootools.html;1280.9167404118737;1410.8377536583293;1431.7422863884499;1586.7619857021446;1770.2034084661905;7004.544704594197;7150.678219480123;7153.070100886877;7161.964190179048;7165.390941769942;7008.948657701348;7139.60732159731;7150.928490715091;7158.284171582839;7163.928360716392;1905.752252207211;1944.8346890514254;2123.883186424746;2207.260567709819;2237.6196046672026;2146.9892650536726;2148.033384976759;2153.8599991000615;2154.10604599092;2154.924577639783;2115.5028568286516;2136.39112852837;2144.2173606633546;2234.765349638281;2245.315178870452;2176.92380766674;2191.41927389242;2200.7579166291694;2203.0747086223823;2203.173809821317;2185.9016344264546;2216.445888527868;2220.1785339424355;2224.1437046737124;2225.2879078694823;7351.485396022281;7435.925640743631;7459.179490256068;7459.8508029839095;7464.328210461084;4553.840615578439;4654.115718013567;4662.743549104798;4663.510331415187;4666.6966647168165;2865.6704478984975;2977.702229777027;2978.240548660078;2998.8800447982053;3002.519596864491;865.68835219321;891.393852180517;900.5632268349846;919;923.0354279777648;10083.042110999517;10097.646582369654;10101.494925253708;10109.24180686444;10116;4310.4611923509565;4398.450193725785;4405.052913623586;4473.642108631302;4503.752293623882;8570.614322355508;8585.012723536749;8628.482291062557;8643.35174861888;8664.393492455594;4559.749213793207;4575.450945886515;4578.725276483422;4584.151931892544;4615.5845973862515;3673.6142705016123;4020.115574573589;4107.589241075869;4114.773687447219;4158.272302347077;3650.306441776107;3703.333399988028;3719.3491139050557;3735.533058367704;3778.7354885158325;1186.211169572225;1198.4487135917575;1201.831743555903;1207;1218.147296892179;966.6133546581283;978.2760757039739;982.2633025231077;1031.1441503552035;1192.6779769462196;7076.71693132269;7098.645067746592;7106.040684507525;7132.607706576188;7147.356737893615;473.3893277671834;1102.525913857049;1118.8937050980144;1143.3654321851452;1150.3443037468562;5419.593530485229;5482.91775623366;5503.889922201533;5508.338999320107;5516.668999860021;8011.559364234907;8259.21537453941;8701.956490217635;8773.824523509495;8814.515201663842;8761.430507017023;8773.780655483537;8796.296296296281;8809;8828.117188281121;6851.417629501449;6858.6570671466225;6907.20567134786;6971.6165610891885;7014.894776578355;6896.586204827727;6903.5167538273845;6920.550164239308;6933.653317334012;6997.615131167631;7747.418943579141;7855.803604909923;7926.445148839526;7983.8802417962615;8070.152633973348;7667.501612395176;7672.5012874163;7685.961570192113;7782.805429864298;8033.55815430157;5701.743421545957;6150.723217455135;6286.968565157145;6402.743890244338;6501.804945851632;6890.31096890307;6894.517383783087;6945.513814032969;6947.40947019509;6960.651967401711;6162.445379915829;6328.493720502441;6335.683215839282;6425.742820851324;6479.092926990319;6303.558750887394;6310.621362718068;6359.936400636119;6400.45596124316;6405.743770249138;6641.900371494335;6656.101426307387;6695.096162018065;6699.263081061177;6700.425400031087;6112.877742445037;6147.047207682816;6174.536909731878;6184;6186.690665466619;6249.750009999549;6254.030625253093;6290.591111577733;6291.496680265659;6296.590721603081 18:23:49 INFO - PROCESS | 9258 | |4;prototype.html;321.7265324474196;324.10062077734284;325.1254126399984;328.38100181158507;330.5603547282115;5343.14509678451;5394;5438.564914806816;5440.646357986733;5456.727163641822;5343.946560534394;5355.732213389334;5371.194320851874;5374.650647707906;5380.24676545284;3992.161646054332;4069.1861627674434;4147.502299724038;4207.200631879949;4229.851955181569;4204.0540878302445;4212.620864122228;4219.43037689911;4221.092465119998;4223.767692776896;4172.33242681171;4173.040200753829;4174.08170202555;4180.958190418102;4186.1418409226035;3942.6845852331744;4040.797960101998;4145.626893579592;4157.210130075307;4157.3140431828715;3656.4698118772894;3661.3226553087497;3671.687906527948;3685.594584595719;3692.280005398948;5145.485451454824;5146.228065790124;5149.253358263069;5154.38147422308;5155.2524883892;4829.903401931977;4834.129856625806;4836.782344794493;4843.29772183035;4857.878553036167;5672.347680016768;5673.404292549306;5679.772809087632;5683.829485115453;5687.7156142193135;4063;4065.8983525411804;4067.7966101694797;4067.8576249831112;4067.9389809152885;5713.457221563945;5912.793052243151;5971.253593300838;5994.7901823436405;5998.580099393044;4033.4554835096887;4089.1003979124544;4089.6932730045364;4094.28350038742;4100.897477563085;4142.751434913915;4146.771927544014;4154.252234597801;4154.376843473443;4156.750594964312;4753.4295884493395;4754.263089221176;4761.095391875532;4766.332713420124;4770.022145460172;5720.056190728483;5723.570732195102;5728.570357223225;5731.570132240098;5732.828015159552;1407.7677183264852;1456.5630310906686;1458.3947661720479;1461.3131828040803;1463.27567853913;884.2130503851578;948.0993056596261;958.1759686669459;973.3332667123043;990.5938565188238;4934.9753251233515;5005.449400565934;5009.924851127236;5020.246962955586;5020.899582008339;5843.678597677169;5866.472017518358;5911.054231322968;5913.704314784243;5917.467427931507;5010.874728131753;5012;5015.423226328946;5021.071101846097;5021.548060674557;3097.3960077784614;3137.9215519611735;3138.5606015157896;3138.827364494929;3139.0582825152364;5507.146392309199;5518.310211223597;5522.447755224526;5526.806561770319;5527.972360138254;5865;6055.2430946131735;6113.938860611337;6121.877562448726;6122.26532816056;5564.081926482166;5619.662820230799;5629.774809007594;5630.971845140748;5636.408177141341;5958.404159584007;5964.910526342195;5972.970135149297;5973.462388385066;5982.551308651956;5818.8254352369495;5835.037218858841;5841.415858414124;5851.239338885917;5853.619514731528;5459.535939445192;5625.268715067015;5627.465390787868;5627.52166065889;5634.8027819027775;4023.557408684984;4042.959570404258;4074.0833312505633;4079.8368065277054;4084.5711200324727;5900.64596124234;5919.260092488439;5935.465808077293;5936.317323507852;5936.554758393224;5711.742971566373;5713;5717.7141142941855;5720.6853623049465;5722.971385143214;5708.457696518824;5718.199452076629;5722.971385143048;5732.054211055296;5735.598508104393;5442.836714898559;5596.720163991866;5645.576581756467;5648.745806438802;5649.943500564942;5708.972384970745;5747.48272655463;5776.306843178845;5776.624519406225;5781.132830075522;5639.351474580311;5644.322681278273;5648.4633959773755;5652.236948012131;5658 18:23:49 INFO - PROCESS | 9258 | |5;yui.html;759.8404335089632;765.7243392378742;770.3759954436906;784.8979632647755;788.0503992688808;14129.929350353246;14371.784423233647;14407.783883241747;14486.492972745957;14522.854771452283;14041.157530548175;14052.156870587747;14074.155550666941;14085.436582536711;14095.154290742563;653.7973228299243;804.1194891593725;806.3508875355336;820.7906983719143;821.7411515372638;803.9879401808978;822.6956026270288;828.362161135925;828.8010877389413;828.9212524810133;831.9084900660922;858.1375717404031;863.0118514301122;863.016161575801;863.7192912303495;684.565301033847;829;850.2305413600701;861.750092473182;866.8699695045731;599.4485073732177;606.9605475644069;621.4158690830604;621.4189732600033;621.7326549583677;11817.763644727143;11826.231294965799;11942.880571194264;11980.940095299467;11982.88017119835;12429.192102513398;12892.742145157044;12923.09538332317;13163.341832908316;13381.26403047832;9941.30410871232;9996.350237234556;10011.399316041061;10107.191424686082;10491.318064325795;3276.3938671345877;3350.8324583770714;3375.3249350129827;3376.7129793967542;3399.5750531183603;46742.53257467416;47021.29468057948;47194;47236;47262.29106563405;9770.462624555576;10039.096481316716;10230.23273254494;10333.431661258703;10335.17318614524;18363.632727345645;18396.81603183951;18419.447416577525;18423.447296581126;18427.26290948347;7028.894566581505;7088.255733148048;7110.893336599956;7181.712731490787;7199.784006479814;3534.2578058607464;3721.4975978243133;3737.4020156774786;3749.606291339425;3849.711271654637;2712.715164907696;2720.3335182879923;2726.386563023304;2736.179146256115;2739.931501712433;463.33742747870866;486.2778773521318;486.96347773917097;488.9682170658896;537.9838604841862;505.630889450703;604.2265899648457;618.5917294585552;619.7335145887222;630.4357599948021;7424.665890034961;7808.336291415179;8027.518348899085;8081.555514446762;8116.228958248957;481.2108142646063;543.7960764713232;560.3052215253057;594.3669991459169;594.6105301027834;3705.277470893204;3709.2581483703366;3759.830807613609;3835.4822099016833;3835.6931445484292;54637;54926.725366373714;55516.16725749117;55619;55715.16427253594;48110.51889481131;49211;49307.26039109416;49334.506654933706;49989.50010499921;43916;44185.558144418785;44352.556474434845;44476.332855006556;44710.32934505985;8591.742247732578;8642.697505587274;8701.260392866678;8725.956370218108;8881.42270752399;31577.21056973594;32011.839940800146;32330.353392931538;33713.32573348568;34950.475742864386;40663.59336406598;41310.586894130676;41529.1694166121;42768.57231427646;42987.14025719531;10295.07344339013;10412.114970227616;10421.478926053514;10563.154947604327;10621.89378106209;11604.30374177552;11956.58151964677;12049.819252711392;12265.632031039084;12313;10933.75500989569;11365;11400.201985860911;11587.942060289644;12131.332776697014;11061.059809916247;11166.05088567481;11540.538378464767;11883.881161188277;12146.696332591757;10798.838017429587;11027.117830573696;11051.17116216271;11057;11613.825792612948;8903.866442003246;8907.599158038034;9136.954315228648;9231;9516.95241523788;9672.419654820733;9712.9028709712;9772.169365604002;9815.2147828175;9824.361416507903 18:23:49 INFO - PROCESS | 9258 | __end_tp_report 18:23:49 INFO - PROCESS | 9258 | __start_cc_report 18:23:49 INFO - PROCESS | 9258 | _x_x_mozilla_cycle_collect,798 18:23:49 INFO - PROCESS | 9258 | __end_cc_report 18:23:49 INFO - PROCESS | 9258 | __startTimestamp1457918629423__endTimestamp 18:23:49 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | ------- Summary: start ------- 18:23:49 INFO - PROCESS | 9258 | Number of tests: 6 18:23:49 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | [#0] dojo.html Cycles:165 Average:4560.41 Median:4710.39 stddev:465.74 (9.9%) stddev-sans-first:440.18 18:23:49 INFO - PROCESS | 9258 | Values: 2568.6 2640.6 2657.1 2660.4 2690.2 4527.0 4557.2 4563.3 4570.0 4663.8 4575.1 4598.3 4611.4 4613.5 4613.7 4141.2 4211.3 4289.9 4325.0 4330.5 4146.8 4237.4 4286.6 4303.7 4305.8 4187.1 4225.3 4235.5 4260.6 4268.3 4206.0 4230.0 4236.4 4237.7 4274.5 4074.6 4123.9 4203.8 4207.3 4264.4 4435.4 4469.4 4522.3 4528.7 4531.9 4890.9 4912.5 4914.1 4915.2 4962.6 4820.0 4917.0 4923.9 4937.2 4974.1 4559.1 4577.8 4599.6 4627.4 4645.2 5013.1 5029.3 5040.9 5052.2 5055.4 4695.4 4809.1 4835.4 4837.1 4857.8 4929.9 4946.4 4948.9 4974.3 5003.6 4894.0 4908.3 4910.8 4916.8 4954.9 4838.6 4872.2 4896.6 4927.1 4939.5 4146.0 4154.9 4157.2 4181.4 4184.9 3663.2 3672.3 3680.0 3693.2 3714.2 4254.8 4286.1 4331.1 4337.8 4347.2 4899.6 4914.4 4917.0 4922.2 4965.2 4303.4 4304.5 4304.8 4348.6 4349.3 4339.3 4432.2 4433.7 4486.8 4513.1 4702.6 4715.8 4738.5 4739.1 4782.6 4948.1 4974.7 4978.8 4980.6 5030.1 4624.3 4645.0 4692.2 4700.5 4739.1 4846.3 4847.0 4864.3 4874.0 4916.2 4854.1 4932.1 4948.1 4948.6 4997.7 4780.5 4804.4 4813.2 4827.5 4856.6 4755.7 4788.3 4792.0 4798.6 4848.9 4688.4 4721.4 4736.3 4739.7 4789.0 4803.0 4823.2 4823.4 4830.9 4876.5 4710.4 4714.5 4719.7 4726.5 4764.8 18:23:49 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | [#1] ext.html Cycles:180 Average:40636.34 Median:34148.66 stddev:66476.72 (194.7%) stddev-sans-first:66594.95 18:23:49 INFO - PROCESS | 9258 | Values: 515.7 520.1 538.7 546.3 557.8 27580.7 28069.4 28164.2 28172.2 36036.0 39118.4 39552.0 39583.6 39598.2 39679.8 7550.4 7727.9 7728.5 7729.1 7734.8 6737.2 6800.1 6807.7 6812.0 6814.1 6889.5 6947.2 6951.6 6962.9 6965.0 6943.5 6947.9 6949.7 6957.5 7013.5 7759.8 7884.9 7885.3 7887.5 7891.6 39731.2 40119.2 40167.8 40238.4 40282.4 3202.4 3306.9 3307.9 3406.1 3625.5 29532.4 29641.7 29770.9 30145.8 30702.7 3429.6 3466.1 3478.1 3482.6 3588.0 237209.0 239683.0 239756.0 240072.0 240324.0 43734.3 44170.0 57802.4 59073.0 59140.4 41696.8 41778.0 41820.0 41836.2 41879.0 14554.6 15021.5 15040.5 15053.0 15053.8 11660.7 11748.1 11765.1 11804.0 11809.4 15020.1 15202.3 15302.8 15321.2 15408.8 5827.1 5964.8 5998.9 6040.5 6047.9 810.4 848.5 884.7 947.6 963.3 26880.2 27943.7 28419.3 28433.6 28485.0 987.3 1001.2 1006.5 1035.4 1075.3 14198.9 14686.0 14779.6 14812.1 14982.3 302301.0 305716.0 305824.0 306603.0 306664.0 47466.0 48183.3 48497.0 48528.0 48623.5 993.5 1153.1 1226.9 1227.0 1324.2 24190.7 27941.4 27982.7 28158.4 28428.6 39363.0 39395.2 39716.0 39735.2 39763.2 207183.0 209017.0 209037.0 210316.0 210644.0 26705.9 31039.2 31438.7 31479.0 32451.2 36036.0 36174.8 36595.5 36704.4 37183.4 31503.5 31521.8 31840.7 31913.4 31939.4 31194.5 33927.0 34106.7 34190.7 34670.5 33404.5 34073.8 34221.3 34375.5 34526.8 30432.2 30818.0 30825.8 31097.0 31146.0 23756.5 24580.8 24596.5 25840.9 26088.9 18:23:49 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | [#2] jquery.html Cycles:180 Average:23451.69 Median:5166.21 stddev:67478.93 (1306.2%) stddev-sans-first:67645.96 18:23:49 INFO - PROCESS | 9258 | Values: 362.7 363.2 368.1 375.2 376.4 15413.6 15967.2 16661.1 16956.1 16987.2 15886.3 16150.1 16484.4 16494.5 16497.6 5043.5 5197.5 5239.4 6013.0 6014.0 5926.6 5955.1 5956.5 5958.9 5988.8 5864.9 5936.5 5936.7 5939.0 5940.1 5736.2 5904.1 5908.9 5913.6 5916.3 5134.9 5252.2 5278.7 5278.8 5312.8 18984.2 19635.3 19779.6 20144.6 20198.9 1879.6 1885.7 1988.0 2037.5 2366.8 12456.8 12816.4 13050.4 13366.9 13555.5 1732.2 1743.3 1747.4 1754.1 1772.6 42389.8 52586.2 53489.5 58329.0 60955.7 9507.0 9655.7 9775.9 9850.2 9866.9 11101.8 11478.6 11866.2 12370.3 12395.9 6751.0 6877.8 7020.5 7160.2 7196.4 6717.8 6734.6 6812.7 6859.9 6907.4 5925.5 5995.6 6047.7 6067.0 6074.1 1710.2 1720.8 1722.6 1732.1 1749.2 876.4 948.1 963.7 978.9 987.0 16206.5 16298.2 16454.7 16516.5 16889.5 878.6 879.8 897.5 948.6 977.6 9719.0 9727.0 9898.3 9909.7 10033.7 391825.0 394102.0 394167.0 436288.0 448764.0 52471.5 62205.4 62739.0 63518.7 63885.4 984.9 987.4 1000.9 1003.1 1003.3 14649.0 14712.8 15051.0 15052.3 15237.8 23208.4 29014.4 29081.6 31483.4 32499.5 34036.3 34557.0 35329.5 35956.1 36075.0 6983.6 7091.1 7099.2 7221.9 7311.3 10697.3 11381.3 11433.9 11443.7 11482.9 9437.3 9501.4 9573.3 9583.7 10100.4 9302.0 9429.0 9544.6 9709.4 10270.9 9154.5 9411.5 9495.4 9550.9 9658.0 6999.1 10261.2 10312.7 10690.7 11020.6 8992.2 9488.2 10107.1 10666.8 10830.4 18:23:49 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | [#3] mootools.html Cycles:180 Average:5155.16 Median:6251.89 stddev:2622.30 (41.9%) stddev-sans-first:2613.48 18:23:49 INFO - PROCESS | 9258 | Values: 1280.9 1410.8 1431.7 1586.8 1770.2 7004.5 7150.7 7153.1 7162.0 7165.4 7008.9 7139.6 7150.9 7158.3 7163.9 1905.8 1944.8 2123.9 2207.3 2237.6 2147.0 2148.0 2153.9 2154.1 2154.9 2115.5 2136.4 2144.2 2234.8 2245.3 2176.9 2191.4 2200.8 2203.1 2203.2 2185.9 2216.4 2220.2 2224.1 2225.3 7351.5 7435.9 7459.2 7459.9 7464.3 4553.8 4654.1 4662.7 4663.5 4666.7 2865.7 2977.7 2978.2 2998.9 3002.5 865.7 891.4 900.6 919.0 923.0 10083.0 10097.6 10101.5 10109.2 10116.0 4310.5 4398.5 4405.1 4473.6 4503.8 8570.6 8585.0 8628.5 8643.4 8664.4 4559.7 4575.5 4578.7 4584.2 4615.6 3673.6 4020.1 4107.6 4114.8 4158.3 3650.3 3703.3 3719.3 3735.5 3778.7 1186.2 1198.4 1201.8 1207.0 1218.1 966.6 978.3 982.3 1031.1 1192.7 7076.7 7098.6 7106.0 7132.6 7147.4 473.4 1102.5 1118.9 1143.4 1150.3 5419.6 5482.9 5503.9 5508.3 5516.7 8011.6 8259.2 8702.0 8773.8 8814.5 8761.4 8773.8 8796.3 8809.0 8828.1 6851.4 6858.7 6907.2 6971.6 7014.9 6896.6 6903.5 6920.6 6933.7 6997.6 7747.4 7855.8 7926.4 7983.9 8070.2 7667.5 7672.5 7686.0 7782.8 8033.6 5701.7 6150.7 6287.0 6402.7 6501.8 6890.3 6894.5 6945.5 6947.4 6960.7 6162.4 6328.5 6335.7 6425.7 6479.1 6303.6 6310.6 6359.9 6400.5 6405.7 6641.9 6656.1 6695.1 6699.3 6700.4 6112.9 6147.0 6174.5 6184.0 6186.7 6249.8 6254.0 6290.6 6291.5 6296.6 18:23:49 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | [#4] prototype.html Cycles:180 Average:4728.62 Median:5387.12 stddev:1395.88 (25.9%) stddev-sans-first:1360.04 18:23:49 INFO - PROCESS | 9258 | Values: 321.7 324.1 325.1 328.4 330.6 5343.1 5394.0 5438.6 5440.6 5456.7 5343.9 5355.7 5371.2 5374.7 5380.2 3992.2 4069.2 4147.5 4207.2 4229.9 4204.1 4212.6 4219.4 4221.1 4223.8 4172.3 4173.0 4174.1 4181.0 4186.1 3942.7 4040.8 4145.6 4157.2 4157.3 3656.5 3661.3 3671.7 3685.6 3692.3 5145.5 5146.2 5149.3 5154.4 5155.3 4829.9 4834.1 4836.8 4843.3 4857.9 5672.3 5673.4 5679.8 5683.8 5687.7 4063.0 4065.9 4067.8 4067.9 4067.9 5713.5 5912.8 5971.3 5994.8 5998.6 4033.5 4089.1 4089.7 4094.3 4100.9 4142.8 4146.8 4154.3 4154.4 4156.8 4753.4 4754.3 4761.1 4766.3 4770.0 5720.1 5723.6 5728.6 5731.6 5732.8 1407.8 1456.6 1458.4 1461.3 1463.3 884.2 948.1 958.2 973.3 990.6 4935.0 5005.4 5009.9 5020.2 5020.9 5843.7 5866.5 5911.1 5913.7 5917.5 5010.9 5012.0 5015.4 5021.1 5021.5 3097.4 3137.9 3138.6 3138.8 3139.1 5507.1 5518.3 5522.4 5526.8 5528.0 5865.0 6055.2 6113.9 6121.9 6122.3 5564.1 5619.7 5629.8 5631.0 5636.4 5958.4 5964.9 5973.0 5973.5 5982.6 5818.8 5835.0 5841.4 5851.2 5853.6 5459.5 5625.3 5627.5 5627.5 5634.8 4023.6 4043.0 4074.1 4079.8 4084.6 5900.6 5919.3 5935.5 5936.3 5936.6 5711.7 5713.0 5717.7 5720.7 5723.0 5708.5 5718.2 5723.0 5732.1 5735.6 5442.8 5596.7 5645.6 5648.7 5649.9 5709.0 5747.5 5776.3 5776.6 5781.1 5639.4 5644.3 5648.5 5652.2 5658.0 18:23:49 INFO - PROCESS | 9258 | 18:23:49 INFO - PROCESS | 9258 | [#5] yui.html Cycles:180 Average:13383.18 Median:44593.33 stddev:15290.58 (34.3%) stddev-sans-first:15304.09 18:23:49 INFO - PROCESS | 9258 | Values: 759.8 765.7 770.4 784.9 788.1 14129.9 14371.8 14407.8 14486.5 14522.9 14041.2 14052.2 14074.2 14085.4 14095.2 653.8 804.1 806.4 820.8 821.7 804.0 822.7 828.4 828.8 828.9 831.9 858.1 863.0 863.0 863.7 684.6 829.0 850.2 861.8 866.9 599.4 607.0 621.4 621.4 621.7 11817.8 11826.2 11942.9 11980.9 11982.9 12429.2 12892.7 12923.1 13163.3 13381.3 9941.3 9996.4 10011.4 10107.2 10491.3 3276.4 3350.8 3375.3 3376.7 3399.6 46742.5 47021.3 47194.0 47236.0 47262.3 9770.5 10039.1 10230.2 10333.4 10335.2 18363.6 18396.8 18419.4 18423.4 18427.3 7028.9 7088.3 7110.9 7181.7 7199.8 3534.3 3721.5 3737.4 3749.6 3849.7 2712.7 2720.3 2726.4 2736.2 2739.9 463.3 486.3 487.0 489.0 538.0 505.6 604.2 618.6 619.7 630.4 7424.7 7808.3 8027.5 8081.6 8116.2 481.2 543.8 560.3 594.4 594.6 3705.3 3709.3 3759.8 3835.5 3835.7 54637.0 54926.7 55516.2 55619.0 55715.2 48110.5 49211.0 49307.3 49334.5 49989.5 43916.0 44185.6 44352.6 44476.3 44710.3 8591.7 8642.7 8701.3 8726.0 8881.4 31577.2 32011.8 32330.4 33713.3 34950.5 40663.6 41310.6 41529.2 42768.6 42987.1 10295.1 10412.1 10421.5 10563.2 10621.9 11604.3 11956.6 12049.8 12265.6 12313.0 10933.8 11365.0 11400.2 11587.9 12131.3 11061.1 11166.1 11540.5 11883.9 12146.7 10798.8 11027.1 11051.2 11057.0 11613.8 8903.9 8907.6 9137.0 9231.0 9517.0 9672.4 9712.9 9772.2 9815.2 9824.4 18:23:49 INFO - PROCESS | 9258 | -------- Summary: end -------- 18:23:49 INFO - PROCESS | 9258 | 18:23:50 INFO - TEST-INFO | 9258: exit 0 18:23:50 INFO - TEST-OK | dromaeo_css | took 1116202ms 18:23:50 INFO - TEST-START | kraken 18:23:50 INFO - operating with platform_type : linux_ 18:23:50 INFO - Initialising browser for kraken test... 18:23:50 INFO - TEST-INFO | started process 9437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk3Lelg/profile http://localhost:57566/getInfo.html) 18:23:54 INFO - PROCESS | 9437 | __metrics Screen width/height:1600/1200 18:23:54 INFO - PROCESS | 9437 | colorDepth:24 18:23:54 INFO - PROCESS | 9437 | Browser inner width/height: 1024/697 18:23:54 INFO - PROCESS | 9437 | __metrics 18:23:55 ERROR - PROCESS | 9437 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:23:56 INFO - TEST-INFO | 9437: exit 0 18:23:56 INFO - Browser initialized. 18:23:56 INFO - Running cycle 1/1 for kraken test... 18:23:56 INFO - TEST-INFO | started process 9521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk3Lelg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:08 INFO - PROCESS | 9521 | RSS: Main: 154075136 18:24:08 INFO - PROCESS | 9521 | 18:24:11 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57566/tests/kraken/driver.html?testName=audio-beat-detection) 18:24:11 INFO - PROCESS | 9521 | RSS: Main: 194580480 18:24:11 INFO - PROCESS | 9521 | 18:24:14 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57566/tests/kraken/driver.html?testName=audio-dft) 18:24:14 INFO - PROCESS | 9521 | RSS: Main: 185876480 18:24:14 INFO - PROCESS | 9521 | 18:24:20 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57566/tests/kraken/driver.html?testName=audio-fft) 18:24:21 INFO - PROCESS | 9521 | RSS: Main: 173584384 18:24:21 INFO - PROCESS | 9521 | 18:24:23 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57566/tests/kraken/driver.html?testName=audio-oscillator) 18:24:23 INFO - PROCESS | 9521 | RSS: Main: 176001024 18:24:23 INFO - PROCESS | 9521 | 18:24:25 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57566/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:24:26 INFO - PROCESS | 9521 | RSS: Main: 176115712 18:24:26 INFO - PROCESS | 9521 | 18:24:29 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57566/tests/kraken/driver.html?testName=imaging-darkroom) 18:24:30 INFO - PROCESS | 9521 | RSS: Main: 175988736 18:24:30 INFO - PROCESS | 9521 | 18:24:34 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57566/tests/kraken/driver.html?testName=imaging-desaturate) 18:24:34 INFO - PROCESS | 9521 | RSS: Main: 173907968 18:24:34 INFO - PROCESS | 9521 | 18:24:37 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57566/tests/kraken/driver.html?testName=json-parse-financial) 18:24:38 INFO - PROCESS | 9521 | RSS: Main: 174370816 18:24:38 INFO - PROCESS | 9521 | 18:24:39 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57566/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:24:40 INFO - PROCESS | 9521 | RSS: Main: 186503168 18:24:40 INFO - PROCESS | 9521 | 18:24:42 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57566/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:24:43 INFO - PROCESS | 9521 | RSS: Main: 184475648 18:24:43 INFO - PROCESS | 9521 | 18:24:45 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57566/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:24:45 INFO - PROCESS | 9521 | RSS: Main: 191975424 18:24:45 INFO - PROCESS | 9521 | 18:24:48 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57566/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:24:48 INFO - PROCESS | 9521 | RSS: Main: 197545984 18:24:48 INFO - PROCESS | 9521 | 18:24:51 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57566/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:24:51 INFO - PROCESS | 9521 | RSS: Main: 197566464 18:24:51 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | Cycle 1(1): loaded http://localhost:57566/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57566/tests/kraken/driver.html?testName=ai-astar) 18:24:53 INFO - PROCESS | 9521 | RSS: Main: 257515520 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | __start_tp_report 18:24:53 INFO - PROCESS | 9521 | _x_x_mozilla_page_load 18:24:53 INFO - PROCESS | 9521 | _x_x_mozilla_page_load_details 18:24:53 INFO - PROCESS | 9521 | |i|pagename|runs| 18:24:53 INFO - PROCESS | 9521 | |0;ai-astar;113;113;108;112;114;114;102;111;114;113 18:24:53 INFO - PROCESS | 9521 | |1;audio-beat-detection;159;130;154;168;130;168;153;130;170;133 18:24:53 INFO - PROCESS | 9521 | |2;audio-dft;394;392;394;393;396;393;393;391;392;393 18:24:53 INFO - PROCESS | 9521 | |3;audio-fft;75;75;74;152;75;76;75;76;150;75 18:24:53 INFO - PROCESS | 9521 | |4;audio-oscillator;94;93;137;93;94;93;142;93;93;136 18:24:53 INFO - PROCESS | 9521 | |5;imaging-gaussian-blur;117;117;117;119;117;116;117;118;117;117 18:24:53 INFO - PROCESS | 9521 | |6;imaging-darkroom;193;194;193;193;193;192;193;194;193;194 18:24:53 INFO - PROCESS | 9521 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;97;96 18:24:53 INFO - PROCESS | 9521 | |8;json-parse-financial;66;66;65;66;65;66;65;65;65;66 18:24:53 INFO - PROCESS | 9521 | |9;json-stringify-tinderbox;64;65;64;66;65;65;64;64;64;64 18:24:53 INFO - PROCESS | 9521 | |10;stanford-crypto-aes;82;81;81;81;80;81;81;81;100;82 18:24:53 INFO - PROCESS | 9521 | |11;stanford-crypto-ccm;115;126;115;122;120;117;117;125;115;122 18:24:53 INFO - PROCESS | 9521 | |12;stanford-crypto-pbkdf2;127;143;141;137;139;127;137;137;148;135 18:24:53 INFO - PROCESS | 9521 | |13;stanford-crypto-sha256-iterative;67;66;67;72;65;65;64;69;65;65 18:24:53 INFO - PROCESS | 9521 | __end_tp_report 18:24:53 INFO - PROCESS | 9521 | __start_cc_report 18:24:53 INFO - PROCESS | 9521 | _x_x_mozilla_cycle_collect,1107 18:24:53 INFO - PROCESS | 9521 | __end_cc_report 18:24:53 INFO - PROCESS | 9521 | __startTimestamp1457918693920__endTimestamp 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | ------- Summary: start ------- 18:24:53 INFO - PROCESS | 9521 | Number of tests: 14 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.78 (3.3%) stddev-sans-first:3.96 18:24:53 INFO - PROCESS | 9521 | Values: 113.0 113.0 108.0 112.0 114.0 114.0 102.0 111.0 114.0 113.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:156.50 stddev:17.13 (10.9%) stddev-sans-first:17.82 18:24:53 INFO - PROCESS | 9521 | Values: 159.0 130.0 154.0 168.0 130.0 168.0 153.0 130.0 170.0 133.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#2] audio-dft Cycles:10 Average:393.10 Median:393.00 stddev:1.37 (0.3%) stddev-sans-first:1.41 18:24:53 INFO - PROCESS | 9521 | Values: 394.0 392.0 394.0 393.0 396.0 393.0 393.0 391.0 392.0 393.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#3] audio-fft Cycles:10 Average:90.30 Median:75.00 stddev:32.00 (42.7%) stddev-sans-first:33.46 18:24:53 INFO - PROCESS | 9521 | Values: 75.0 75.0 74.0 152.0 75.0 76.0 75.0 76.0 150.0 75.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:21.82 (23.5%) stddev-sans-first:22.64 18:24:53 INFO - PROCESS | 9521 | Values: 94.0 93.0 137.0 93.0 94.0 93.0 142.0 93.0 93.0 136.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 18:24:53 INFO - PROCESS | 9521 | Values: 117.0 117.0 117.0 119.0 117.0 116.0 117.0 118.0 117.0 117.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#6] imaging-darkroom Cycles:10 Average:193.20 Median:193.00 stddev:0.63 (0.3%) stddev-sans-first:0.67 18:24:53 INFO - PROCESS | 9521 | Values: 193.0 194.0 193.0 193.0 193.0 192.0 193.0 194.0 193.0 194.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 18:24:53 INFO - PROCESS | 9521 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 97.0 96.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 18:24:53 INFO - PROCESS | 9521 | Values: 66.0 66.0 65.0 66.0 65.0 66.0 65.0 65.0 65.0 66.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 18:24:53 INFO - PROCESS | 9521 | Values: 64.0 65.0 64.0 66.0 65.0 65.0 64.0 64.0 64.0 64.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:81.00 stddev:6.00 (7.4%) stddev-sans-first:6.35 18:24:53 INFO - PROCESS | 9521 | Values: 82.0 81.0 81.0 81.0 80.0 81.0 81.0 81.0 100.0 82.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:121.00 stddev:4.20 (3.5%) stddev-sans-first:4.14 18:24:53 INFO - PROCESS | 9521 | Values: 115.0 126.0 115.0 122.0 120.0 117.0 117.0 125.0 115.0 122.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:138.00 stddev:6.51 (4.7%) stddev-sans-first:5.78 18:24:53 INFO - PROCESS | 9521 | Values: 127.0 143.0 141.0 137.0 139.0 127.0 137.0 137.0 148.0 135.0 18:24:53 INFO - PROCESS | 9521 | 18:24:53 INFO - PROCESS | 9521 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:2.42 (3.6%) stddev-sans-first:2.55 18:24:53 INFO - PROCESS | 9521 | Values: 67.0 66.0 67.0 72.0 65.0 65.0 64.0 69.0 65.0 65.0 18:24:53 INFO - PROCESS | 9521 | -------- Summary: end -------- 18:24:53 INFO - PROCESS | 9521 | 18:24:54 INFO - TEST-INFO | 9521: exit 0 18:24:55 INFO - TEST-OK | kraken | took 64917ms 18:24:55 INFO - SUITE-END | took 1181s 18:24:55 INFO - Completed test suite (00:19:41) 18:24:55 INFO - javascript benchmark 18:24:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2568.6275490053945, 2640.6303117563557, 2657.0700254910785, 2660.3615132368236, 2690.179495253947, 4526.981429178441, 4557.202489564322, 4563.292689633108, 4569.977150114249, 4663.766811659412, 4575.107853968478, 4598.2872654738485, 4611.423572053493, 4613.538646135385, 4613.746243956581, 4141.151064031881, 4211.305134652786, 4289.935650965238, 4325.048489332342, 4330.545292744248, 4146.8133933972895, 4237.364395340693, 4286.57134286572, 4303.720258183208, 4305.763183024932, 4187.057911969813, 4225.281702110648, 4235.470566179228, 4260.616544511009, 4268.295731204347, 4205.990562265065, 4230.0, 4236.364545318227, 4237.724547904407, 4274.529801721808, 4074.5925407459313, 4123.9175216495805, 4203.810828512725, 4207.284761590507, 4264.381664658638, 4435.379046933432, 4469.351943968139, 4522.3216517522305, 4528.705634133804, 4531.886702832423, 4890.877728056791, 4912.533309335608, 4914.140025495524, 4915.238138088602, 4962.578180854632, 4819.975900120512, 4916.975415122902, 4923.926141107886, 4937.21004639256, 4974.054929563371, 4559.065391594749, 4577.8397756078375, 4599.586037256596, 4627.444706635191, 4645.233536466445, 5013.147764879979, 5029.346184995927, 5040.873978150576, 5052.191649336089, 5055.368078990126, 4695.436547614308, 4809.062232864628, 4835.419749630067, 4837.080954618682, 4857.781399837016, 4929.926051109236, 4946.431160416526, 4948.925766113512, 4974.303597496353, 5003.574696150795, 4894.045661096124, 4908.288298196741, 4910.828121015818, 4916.803327866845, 4954.9009019819405, 4838.637102217277, 4872.19608764557, 4896.5837903777865, 4927.063857866994, 4939.456659767423, 4146.0, 4154.896127596774, 4157.189348077157, 4181.414601955728, 4184.8744537663915, 3663.2124093320062, 3672.265546890633, 3680.0063982724514, 3693.2059607184583, 3714.1643130295465, 4254.787260636956, 4286.057067445157, 4331.068820203608, 4337.82648694055, 4347.217500849814, 4899.559039686445, 4914.410270767531, 4916.975415122973, 4922.237053256751, 4965.180745177077, 4303.440552728188, 4304.504981927056, 4304.82780688769, 4348.608625223745, 4349.26062569364, 4339.305711086274, 4432.180046691373, 4433.7118087324225, 4486.820527178941, 4513.11994161142, 4702.576768090888, 4715.81136754526, 4738.502457242078, 4739.123262196505, 4782.641301902441, 4948.05986862495, 4974.676646017997, 4978.775955082103, 4980.551750342486, 5030.144875371123, 4624.28323609841, 4645.0, 4692.225782745809, 4700.482946875909, 4739.075880203327, 4846.345743324606, 4847.030593881167, 4864.318995340726, 4874.0, 4916.164252077084, 4854.101991131652, 4932.062908047459, 4948.134076536519, 4948.628852836124, 4997.675151115166, 4780.521947805191, 4804.375431193923, 4813.181759100891, 4827.517248275144, 4856.635752318661, 4755.690880092783, 4788.3056956741775, 4792.0, 4798.616110711205, 4848.878778030577, 4688.390509233778, 4721.433427988663, 4736.289556566542, 4739.739314337745, 4788.976055119702, 4803.03939212152, 4823.1800593899825, 4823.397075365579, 4830.903381932412, 4876.512348765095, 4710.387649605529, 4714.504976977368, 4719.716816990992, 4726.480087190337, 4764.76176191196], "unit": "score", "name": "dojo.html", "value": 4531.729719315339}, {"lowerIsBetter": false, "replicates": [515.7060475528948, 520.0509070945524, 538.6552606331951, 546.3143754587993, 557.7796770275742, 27580.724192758065, 28069.438611227764, 28164.15507534772, 28172.154835354948, 36036.0, 39118.41322380167, 39552.0, 39583.60416395835, 39598.208035839336, 39679.80160099195, 7550.395968322521, 7727.8794574786625, 7728.459007869451, 7729.072511298652, 7734.8453030939345, 6737.225219099792, 6800.1159849219775, 6807.659617019154, 6811.965940170317, 6814.080099186596, 6889.483288753364, 6947.201071876723, 6951.58290502569, 6962.89555656663, 6964.965175174142, 6943.548669336477, 6947.89578156328, 6949.722011119549, 6957.47818913581, 7013.544119632233, 7759.844803103906, 7884.921150788476, 7885.329746971457, 7887.487313324616, 7891.6054197289905, 39731.20537589261, 40119.19761604781, 40167.7991610043, 40238.396424053666, 40282.39576406356, 3202.407554602383, 3306.947582636288, 3307.9007629771145, 3406.148462884279, 3625.546806649169, 29532.409351812843, 29641.703582964325, 29770.85114574435, 30145.849270753504, 30702.692973070207, 3429.605595356516, 3466.0814884055744, 3478.130467383154, 3482.5995010573856, 3588.049166970755, 237209.0, 239683.0, 239756.0, 240072.0, 240324.0, 43734.343984840256, 44170.0, 57802.42197578055, 59073.0, 59140.40859591435, 41696.79151604223, 41778.0, 41820.0, 41836.163276734296, 41879.0, 14554.636134096732, 15021.549353519413, 15040.548783536511, 15053.0, 15053.849461505244, 11660.708482288012, 11748.118891083202, 11765.058795296356, 11804.0, 11809.350485723196, 15020.09879407239, 15202.315895784715, 15302.846971530142, 15321.157336346385, 15408.845911540966, 5827.096799996008, 5964.761409543657, 5998.880022399615, 6040.546958978094, 6047.909281360783, 810.4003037752021, 848.5036253791478, 884.7478468636408, 947.6446332625266, 963.349738926222, 26880.193594192206, 27943.72056279452, 28419.28951776181, 28433.57349639757, 28485.0, 987.3236832769576, 1001.1940387987594, 1006.4615430744662, 1035.4253389368973, 1075.3010543147018, 14198.85801141996, 14686.0, 14779.556613301618, 14812.058795807043, 14982.250887455584, 302301.0, 305716.0, 305824.0, 306603.0, 306664.0, 47466.0, 48183.27725084127, 48497.0, 48528.0, 48623.5137648619, 993.4734590666958, 1153.1063425845036, 1226.8834460726216, 1227.0, 1324.1922427319134, 24190.669513176945, 27941.441171176055, 27982.72017279801, 28158.43683126285, 28428.57357139603, 39363.0, 39395.21209575735, 39716.0, 39735.20529589334, 39763.22249386304, 207183.0, 209017.0, 209037.0, 210316.0, 210644.0, 26705.866470667523, 31039.224019399695, 31438.685613143574, 31479.0, 32451.18872028218, 36036.0, 36174.8191259042, 36595.45106823453, 36704.449433257985, 37183.44224836684, 31503.52744708877, 31521.8423907879, 31840.681593184698, 31913.36173276568, 31939.36121277608, 31194.532082018333, 33927.0, 34106.65893341035, 34190.658093418744, 34670.479942800375, 33404.49893251555, 34073.82963085169, 34221.31557368889, 34375.48436773501, 34526.82736586301, 30432.239194020327, 30818.0, 30825.845870770503, 31097.0, 31146.0, 23756.45583037097, 24580.754192457847, 24596.508069838146, 25840.8707956459, 26088.86955565286], "unit": "score", "name": "ext.html", "value": 16513.773833807605}, {"lowerIsBetter": false, "replicates": [362.717080677072, 363.1918980268902, 368.1312103435891, 375.24201113750223, 376.4447440025964, 15413.614659633515, 15967.201639918016, 16661.08364039979, 16956.0674162921, 16987.23557439915, 15886.285117169726, 16150.111743854084, 16484.42304519342, 16494.505164845075, 16497.587560311, 5043.470435604264, 5197.532222100011, 5239.449857764937, 6012.96993515034, 6014.0, 5926.585139040269, 5955.136505206742, 5956.523478121761, 5958.940410595882, 5988.790392336269, 5864.882702345951, 5936.465718085371, 5936.7328470218945, 5938.990371636832, 5940.138679891435, 5736.196932429463, 5904.055351143839, 5908.911366329508, 5913.586048976574, 5916.26046744157, 5134.897302053938, 5252.185911183773, 5278.736063196825, 5278.815241466568, 5312.787488500456, 18984.240630374767, 19635.31276405319, 19779.604407911906, 20144.59710805776, 20198.899005505027, 1879.5864909719976, 1885.7454243677066, 1987.9701804472945, 2037.4702577330002, 2366.7988221001237, 12456.81314780279, 12816.35918204086, 13050.412731427108, 13366.86633133666, 13555.525556605471, 1732.2205007746438, 1743.2591148761726, 1747.3796802135187, 1754.0528114817982, 1772.5745821002865, 42389.788051059855, 52586.211206831926, 53489.465105348834, 58329.0, 60955.69522152361, 9507.0, 9655.710328690151, 9775.85336219943, 9850.162736167505, 9866.851997220047, 11101.777964440827, 11478.598249061242, 11866.228695134789, 12370.319632420124, 12395.876041239471, 6750.966245168743, 6877.793666189922, 7020.508564400545, 7160.248173941765, 7196.388306993859, 6717.832054198587, 6734.595924244561, 6812.6934287957165, 6859.9314006860295, 6907.412869906114, 5925.459380561085, 5995.550333724988, 6047.697615119227, 6067.0, 6074.058520929263, 1710.187660861106, 1720.7590937268792, 1722.5607470095047, 1732.1252767352657, 1749.212854215608, 876.4434584039182, 948.0850978805486, 963.6530848894392, 978.858065580501, 986.9654562090292, 16206.513804585882, 16298.185090745415, 16454.670906581803, 16516.50450486487, 16889.493315200565, 878.5607196401799, 879.8108406692592, 897.4794619120894, 948.5778828421425, 977.5503268496429, 9718.951405242928, 9727.0, 9898.257630677728, 9909.65316213929, 10033.698989030341, 391825.0, 394102.0, 394167.0, 436288.0, 448764.0, 52471.475285246655, 62205.37794621996, 62739.0, 63518.682406588596, 63885.36114638794, 984.8670429491926, 987.4026214140629, 1000.8548760429696, 1003.117256813999, 1003.3177439341172, 14649.0, 14712.77930831017, 15051.0, 15052.3226454812, 15237.771433428286, 23208.419789504722, 29014.419711605227, 29081.563776543793, 31483.37033259276, 32499.512507311938, 34036.319273613895, 34557.0, 35329.47005794864, 35956.101097472776, 36075.0, 6983.615901125284, 7091.11361079865, 7099.183593886769, 7221.855562888818, 7311.305425984523, 10697.304675196086, 11381.260218085798, 11433.885661143282, 11443.713907152387, 11482.885171148182, 9437.339386243171, 9501.382410143318, 9573.32986690925, 9583.664571739955, 10100.393976361442, 9302.0, 9429.0, 9544.570494327632, 9709.36889102206, 10270.897291026995, 9154.496502692416, 9411.529423528933, 9495.43027418357, 9550.904490955001, 9657.951710241685, 6999.12510936133, 10261.179105671677, 10312.690619281433, 10690.73273168177, 11020.559177633126, 8992.235659968976, 9488.240940724587, 10107.090361867467, 10666.773321068176, 10830.40432776205], "unit": "score", "name": "jquery.html", "value": 8149.556258594386}, {"lowerIsBetter": false, "replicates": [1280.9167404118737, 1410.8377536583293, 1431.7422863884499, 1586.7619857021446, 1770.2034084661905, 7004.544704594197, 7150.678219480123, 7153.070100886877, 7161.964190179048, 7165.390941769942, 7008.948657701348, 7139.60732159731, 7150.928490715091, 7158.284171582839, 7163.928360716392, 1905.752252207211, 1944.8346890514254, 2123.883186424746, 2207.260567709819, 2237.6196046672026, 2146.9892650536726, 2148.033384976759, 2153.8599991000615, 2154.10604599092, 2154.924577639783, 2115.5028568286516, 2136.39112852837, 2144.2173606633546, 2234.765349638281, 2245.315178870452, 2176.92380766674, 2191.41927389242, 2200.7579166291694, 2203.0747086223823, 2203.173809821317, 2185.9016344264546, 2216.445888527868, 2220.1785339424355, 2224.1437046737124, 2225.2879078694823, 7351.485396022281, 7435.925640743631, 7459.179490256068, 7459.8508029839095, 7464.328210461084, 4553.840615578439, 4654.115718013567, 4662.743549104798, 4663.510331415187, 4666.6966647168165, 2865.6704478984975, 2977.702229777027, 2978.240548660078, 2998.8800447982053, 3002.519596864491, 865.68835219321, 891.393852180517, 900.5632268349846, 919.0, 923.0354279777648, 10083.042110999517, 10097.646582369654, 10101.494925253708, 10109.24180686444, 10116.0, 4310.4611923509565, 4398.450193725785, 4405.052913623586, 4473.642108631302, 4503.752293623882, 8570.614322355508, 8585.012723536749, 8628.482291062557, 8643.35174861888, 8664.393492455594, 4559.749213793207, 4575.450945886515, 4578.725276483422, 4584.151931892544, 4615.5845973862515, 3673.6142705016123, 4020.115574573589, 4107.589241075869, 4114.773687447219, 4158.272302347077, 3650.306441776107, 3703.333399988028, 3719.3491139050557, 3735.533058367704, 3778.7354885158325, 1186.211169572225, 1198.4487135917575, 1201.831743555903, 1207.0, 1218.147296892179, 966.6133546581283, 978.2760757039739, 982.2633025231077, 1031.1441503552035, 1192.6779769462196, 7076.71693132269, 7098.645067746592, 7106.040684507525, 7132.607706576188, 7147.356737893615, 473.3893277671834, 1102.525913857049, 1118.8937050980144, 1143.3654321851452, 1150.3443037468562, 5419.593530485229, 5482.91775623366, 5503.889922201533, 5508.338999320107, 5516.668999860021, 8011.559364234907, 8259.21537453941, 8701.956490217635, 8773.824523509495, 8814.515201663842, 8761.430507017023, 8773.780655483537, 8796.296296296281, 8809.0, 8828.117188281121, 6851.417629501449, 6858.6570671466225, 6907.20567134786, 6971.6165610891885, 7014.894776578355, 6896.586204827727, 6903.5167538273845, 6920.550164239308, 6933.653317334012, 6997.615131167631, 7747.418943579141, 7855.803604909923, 7926.445148839526, 7983.8802417962615, 8070.152633973348, 7667.501612395176, 7672.5012874163, 7685.961570192113, 7782.805429864298, 8033.55815430157, 5701.743421545957, 6150.723217455135, 6286.968565157145, 6402.743890244338, 6501.804945851632, 6890.31096890307, 6894.517383783087, 6945.513814032969, 6947.40947019509, 6960.651967401711, 6162.445379915829, 6328.493720502441, 6335.683215839282, 6425.742820851324, 6479.092926990319, 6303.558750887394, 6310.621362718068, 6359.936400636119, 6400.45596124316, 6405.743770249138, 6641.900371494335, 6656.101426307387, 6695.096162018065, 6699.263081061177, 6700.425400031087, 6112.877742445037, 6147.047207682816, 6174.536909731878, 6184.0, 6186.690665466619, 6249.750009999549, 6254.030625253093, 6290.591111577733, 6291.496680265659, 6296.590721603081], "unit": "score", "name": "mootools.html", "value": 4249.536889593174}, {"lowerIsBetter": false, "replicates": [321.7265324474196, 324.10062077734284, 325.1254126399984, 328.38100181158507, 330.5603547282115, 5343.14509678451, 5394.0, 5438.564914806816, 5440.646357986733, 5456.727163641822, 5343.946560534394, 5355.732213389334, 5371.194320851874, 5374.650647707906, 5380.24676545284, 3992.161646054332, 4069.1861627674434, 4147.502299724038, 4207.200631879949, 4229.851955181569, 4204.0540878302445, 4212.620864122228, 4219.43037689911, 4221.092465119998, 4223.767692776896, 4172.33242681171, 4173.040200753829, 4174.08170202555, 4180.958190418102, 4186.1418409226035, 3942.6845852331744, 4040.797960101998, 4145.626893579592, 4157.210130075307, 4157.3140431828715, 3656.4698118772894, 3661.3226553087497, 3671.687906527948, 3685.594584595719, 3692.280005398948, 5145.485451454824, 5146.228065790124, 5149.253358263069, 5154.38147422308, 5155.2524883892, 4829.903401931977, 4834.129856625806, 4836.782344794493, 4843.29772183035, 4857.878553036167, 5672.347680016768, 5673.404292549306, 5679.772809087632, 5683.829485115453, 5687.7156142193135, 4063.0, 4065.8983525411804, 4067.7966101694797, 4067.8576249831112, 4067.9389809152885, 5713.457221563945, 5912.793052243151, 5971.253593300838, 5994.7901823436405, 5998.580099393044, 4033.4554835096887, 4089.1003979124544, 4089.6932730045364, 4094.28350038742, 4100.897477563085, 4142.751434913915, 4146.771927544014, 4154.252234597801, 4154.376843473443, 4156.750594964312, 4753.4295884493395, 4754.263089221176, 4761.095391875532, 4766.332713420124, 4770.022145460172, 5720.056190728483, 5723.570732195102, 5728.570357223225, 5731.570132240098, 5732.828015159552, 1407.7677183264852, 1456.5630310906686, 1458.3947661720479, 1461.3131828040803, 1463.27567853913, 884.2130503851578, 948.0993056596261, 958.1759686669459, 973.3332667123043, 990.5938565188238, 4934.9753251233515, 5005.449400565934, 5009.924851127236, 5020.246962955586, 5020.899582008339, 5843.678597677169, 5866.472017518358, 5911.054231322968, 5913.704314784243, 5917.467427931507, 5010.874728131753, 5012.0, 5015.423226328946, 5021.071101846097, 5021.548060674557, 3097.3960077784614, 3137.9215519611735, 3138.5606015157896, 3138.827364494929, 3139.0582825152364, 5507.146392309199, 5518.310211223597, 5522.447755224526, 5526.806561770319, 5527.972360138254, 5865.0, 6055.2430946131735, 6113.938860611337, 6121.877562448726, 6122.26532816056, 5564.081926482166, 5619.662820230799, 5629.774809007594, 5630.971845140748, 5636.408177141341, 5958.404159584007, 5964.910526342195, 5972.970135149297, 5973.462388385066, 5982.551308651956, 5818.8254352369495, 5835.037218858841, 5841.415858414124, 5851.239338885917, 5853.619514731528, 5459.535939445192, 5625.268715067015, 5627.465390787868, 5627.52166065889, 5634.8027819027775, 4023.557408684984, 4042.959570404258, 4074.0833312505633, 4079.8368065277054, 4084.5711200324727, 5900.64596124234, 5919.260092488439, 5935.465808077293, 5936.317323507852, 5936.554758393224, 5711.742971566373, 5713.0, 5717.7141142941855, 5720.6853623049465, 5722.971385143214, 5708.457696518824, 5718.199452076629, 5722.971385143048, 5732.054211055296, 5735.598508104393, 5442.836714898559, 5596.720163991866, 5645.576581756467, 5648.745806438802, 5649.943500564942, 5708.972384970745, 5747.48272655463, 5776.306843178845, 5776.624519406225, 5781.132830075522, 5639.351474580311, 5644.322681278273, 5648.4633959773755, 5652.236948012131, 5658.0], "unit": "score", "name": "prototype.html", "value": 4281.51055378604}, {"lowerIsBetter": false, "replicates": [759.8404335089632, 765.7243392378742, 770.3759954436906, 784.8979632647755, 788.0503992688808, 14129.929350353246, 14371.784423233647, 14407.783883241747, 14486.492972745957, 14522.854771452283, 14041.157530548175, 14052.156870587747, 14074.155550666941, 14085.436582536711, 14095.154290742563, 653.7973228299243, 804.1194891593725, 806.3508875355336, 820.7906983719143, 821.7411515372638, 803.9879401808978, 822.6956026270288, 828.362161135925, 828.8010877389413, 828.9212524810133, 831.9084900660922, 858.1375717404031, 863.0118514301122, 863.016161575801, 863.7192912303495, 684.565301033847, 829.0, 850.2305413600701, 861.750092473182, 866.8699695045731, 599.4485073732177, 606.9605475644069, 621.4158690830604, 621.4189732600033, 621.7326549583677, 11817.763644727143, 11826.231294965799, 11942.880571194264, 11980.940095299467, 11982.88017119835, 12429.192102513398, 12892.742145157044, 12923.09538332317, 13163.341832908316, 13381.26403047832, 9941.30410871232, 9996.350237234556, 10011.399316041061, 10107.191424686082, 10491.318064325795, 3276.3938671345877, 3350.8324583770714, 3375.3249350129827, 3376.7129793967542, 3399.5750531183603, 46742.53257467416, 47021.29468057948, 47194.0, 47236.0, 47262.29106563405, 9770.462624555576, 10039.096481316716, 10230.23273254494, 10333.431661258703, 10335.17318614524, 18363.632727345645, 18396.81603183951, 18419.447416577525, 18423.447296581126, 18427.26290948347, 7028.894566581505, 7088.255733148048, 7110.893336599956, 7181.712731490787, 7199.784006479814, 3534.2578058607464, 3721.4975978243133, 3737.4020156774786, 3749.606291339425, 3849.711271654637, 2712.715164907696, 2720.3335182879923, 2726.386563023304, 2736.179146256115, 2739.931501712433, 463.33742747870866, 486.2778773521318, 486.96347773917097, 488.9682170658896, 537.9838604841862, 505.630889450703, 604.2265899648457, 618.5917294585552, 619.7335145887222, 630.4357599948021, 7424.665890034961, 7808.336291415179, 8027.518348899085, 8081.555514446762, 8116.228958248957, 481.2108142646063, 543.7960764713232, 560.3052215253057, 594.3669991459169, 594.6105301027834, 3705.277470893204, 3709.2581483703366, 3759.830807613609, 3835.4822099016833, 3835.6931445484292, 54637.0, 54926.725366373714, 55516.16725749117, 55619.0, 55715.16427253594, 48110.51889481131, 49211.0, 49307.26039109416, 49334.506654933706, 49989.50010499921, 43916.0, 44185.558144418785, 44352.556474434845, 44476.332855006556, 44710.32934505985, 8591.742247732578, 8642.697505587274, 8701.260392866678, 8725.956370218108, 8881.42270752399, 31577.21056973594, 32011.839940800146, 32330.353392931538, 33713.32573348568, 34950.475742864386, 40663.59336406598, 41310.586894130676, 41529.1694166121, 42768.57231427646, 42987.14025719531, 10295.07344339013, 10412.114970227616, 10421.478926053514, 10563.154947604327, 10621.89378106209, 11604.30374177552, 11956.58151964677, 12049.819252711392, 12265.632031039084, 12313.0, 10933.75500989569, 11365.0, 11400.201985860911, 11587.942060289644, 12131.332776697014, 11061.059809916247, 11166.05088567481, 11540.538378464767, 11883.881161188277, 12146.696332591757, 10798.838017429587, 11027.117830573696, 11051.17116216271, 11057.0, 11613.825792612948, 8903.866442003246, 8907.599158038034, 9136.954315228648, 9231.0, 9516.95241523788, 9672.419654820733, 9712.9028709712, 9772.169365604002, 9815.2147828175, 9824.361416507903], "unit": "score", "name": "yui.html", "value": 6082.6696442019565}], "name": "dromaeo_css", "value": 6380.967569878006}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 108.0, 112.0, 114.0, 114.0, 102.0, 111.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [159.0, 130.0, 154.0, 168.0, 130.0, 168.0, 153.0, 130.0, 170.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [394.0, 392.0, 394.0, 393.0, 396.0, 393.0, 393.0, 391.0, 392.0, 393.0], "unit": "score", "name": "audio-dft", "value": 393.1}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 74.0, 152.0, 75.0, 76.0, 75.0, 76.0, 150.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 137.0, 93.0, 94.0, 93.0, 142.0, 93.0, 93.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [193.0, 194.0, 193.0, 193.0, 193.0, 192.0, 193.0, 194.0, 193.0, 194.0], "unit": "score", "name": "imaging-darkroom", "value": 193.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 65.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 66.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 81.0, 81.0, 80.0, 81.0, 81.0, 81.0, 100.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [115.0, 126.0, 115.0, 122.0, 120.0, 117.0, 117.0, 125.0, 115.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [127.0, 143.0, 141.0, 137.0, 139.0, 127.0, 137.0, 137.0, 148.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 72.0, 65.0, 65.0, 64.0, 69.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1793.1}]} 18:24:55 INFO - Return code: 0 18:24:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:24:55 ERROR - # TBPL SUCCESS # 18:24:55 INFO - Running post-action listener: _resource_record_post_action 18:24:55 INFO - Running post-run listener: _resource_record_post_run 18:24:56 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 344064; Write bytes: 359972864; Read time: 308; Write time: 191484 18:24:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 67379200; Read time: 172; Write time: 27332 18:24:56 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 339968; Write bytes: 287219712; Read time: 136; Write time: 163080 18:24:56 INFO - Running post-run listener: _upload_blobber_files 18:24:56 INFO - Blob upload gear active. 18:24:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:24:56 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:24:56 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:24:56 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:24:56 INFO - (blobuploader) - INFO - Open directory for files ... 18:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:24:57 INFO - (blobuploader) - INFO - Done attempting. 18:24:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:24:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:24:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:24:58 INFO - (blobuploader) - INFO - Done attempting. 18:24:58 INFO - (blobuploader) - INFO - Iteration through files over. 18:24:58 INFO - Return code: 0 18:24:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:24:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:24:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6763b600dd281b5f863e2f35033ac992f91c5a310f294a3cd72cfe819b56979d2714fcc18c3f5e9d1b8234d78be3bdee3532ee9235c100974ebf8832e3357dad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b874ae0cedf12ebfcc25cd8f6c2cddd0e5653c5604621afb562b0e94e1a9379ff53d4715bf4fae0d2baf578385c98eba5cc30e6bf4fbfc577cc31f7805b646c"} 18:24:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:24:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:24:58 INFO - Contents: 18:24:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6763b600dd281b5f863e2f35033ac992f91c5a310f294a3cd72cfe819b56979d2714fcc18c3f5e9d1b8234d78be3bdee3532ee9235c100974ebf8832e3357dad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b874ae0cedf12ebfcc25cd8f6c2cddd0e5653c5604621afb562b0e94e1a9379ff53d4715bf4fae0d2baf578385c98eba5cc30e6bf4fbfc577cc31f7805b646c"} 18:24:58 INFO - Running post-run listener: copy_logs_to_upload_dir 18:24:58 INFO - Copying logs to upload dir... 18:24:58 INFO - mkdir: /builds/slave/test/build/upload/logs 18:24:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.328079 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-03-13 18:24:58.488145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 18:24:58.491995) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 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/6763b600dd281b5f863e2f35033ac992f91c5a310f294a3cd72cfe819b56979d2714fcc18c3f5e9d1b8234d78be3bdee3532ee9235c100974ebf8832e3357dad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b874ae0cedf12ebfcc25cd8f6c2cddd0e5653c5604621afb562b0e94e1a9379ff53d4715bf4fae0d2baf578385c98eba5cc30e6bf4fbfc577cc31f7805b646c"} build_url:https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://queue.taskcluster.net/v1/task/B9C6xVPpSpCMlGPHfxzUUQ/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/6763b600dd281b5f863e2f35033ac992f91c5a310f294a3cd72cfe819b56979d2714fcc18c3f5e9d1b8234d78be3bdee3532ee9235c100974ebf8832e3357dad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b874ae0cedf12ebfcc25cd8f6c2cddd0e5653c5604621afb562b0e94e1a9379ff53d4715bf4fae0d2baf578385c98eba5cc30e6bf4fbfc577cc31f7805b646c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 18:24:58.518033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:24:58.518374) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1457916223.132986-1808584996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 18:24:58.606256) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 18:24:58.606822) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 18:24:58.607323) ========= ========= Total master_lag: 0.31 =========