builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1459180811.21 results: success (0) buildid: 20160328080848 builduid: 432e2e87b9b64c2a902e134a41a0d6e2 revision: 334c1b88d28a46e3ebefbd42a55190bee4b3fefc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.210271) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.210611) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.210907) ========= 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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006421 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.274221) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.274480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.403935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.404173) ========= 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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.485543) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.485808) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.486115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.486374) ========= 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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-28 09:00:11-- 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% 95.5M=0s 2016-03-28 09:00:11 (95.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144007 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.682271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.682545) ========= 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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017884 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.761067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:11.761398) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 334c1b88d28a46e3ebefbd42a55190bee4b3fefc --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 334c1b88d28a46e3ebefbd42a55190bee4b3fefc --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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-28 09:00:11,926 truncating revision to first 12 chars 2016-03-28 09:00:11,926 Setting DEBUG logging. 2016-03-28 09:00:11,926 attempt 1/10 2016-03-28 09:00:11,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/334c1b88d28a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 09:00:12,218 unpacking tar archive at: fx-team-334c1b88d28a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:12.399008) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:12.399465) ========= echo 334c1b88d28a46e3ebefbd42a55190bee4b3fefc in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'334c1b88d28a46e3ebefbd42a55190bee4b3fefc'] 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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 334c1b88d28a46e3ebefbd42a55190bee4b3fefc program finished with exit code 0 elapsedTime=0.004853 script_repo_revision: '334c1b88d28a46e3ebefbd42a55190bee4b3fefc' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:12.486593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:12.487335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 09:00:12.500810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-03-28 09:00:12.501480) ========= /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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:00:12 INFO - MultiFileLogger online at 20160328 09:00:12 in /builds/slave/test 09:00:12 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 09:00:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:00:12 INFO - {'append_to_log': False, 09:00:12 INFO - 'base_work_dir': '/builds/slave/test', 09:00:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:00:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:00:12 INFO - 'branch': 'Fx-Team-Non-PGO', 09:00:12 INFO - 'buildbot_json_path': 'buildprops.json', 09:00:12 INFO - 'config_files': ('talos/linux_config.py',), 09:00:12 INFO - 'default_actions': ('clobber', 09:00:12 INFO - 'read-buildbot-config', 09:00:12 INFO - 'download-and-extract', 09:00:12 INFO - 'populate-webroot', 09:00:12 INFO - 'create-virtualenv', 09:00:12 INFO - 'install', 09:00:12 INFO - 'run-tests'), 09:00:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:00:12 INFO - 'download_minidump_stackwalk': True, 09:00:12 INFO - 'download_symbols': 'ondemand', 09:00:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:00:12 INFO - 'tooltool.py': '/tools/tooltool.py', 09:00:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:00:12 INFO - '/tools/misc-python/virtualenv.py')}, 09:00:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:00:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:00:12 INFO - 'installer_path': 'installer.exe', 09:00:12 INFO - 'log_level': 'info', 09:00:12 INFO - 'log_name': 'talos', 09:00:12 INFO - 'log_to_console': True, 09:00:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:00:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:00:12 INFO - 'opt_config_files': (), 09:00:12 INFO - 'pip_index': False, 09:00:12 INFO - 'sps_profile': False, 09:00:12 INFO - 'sps_profile_interval': 0, 09:00:12 INFO - 'suite': 'dromaeojs', 09:00:12 INFO - 'system_bits': '32', 09:00:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:00:12 INFO - 'title': 'talos-linux64-ix-065', 09:00:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:00:12 INFO - 'use_talos_json': True, 09:00:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:00:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:00:12 INFO - 'work_dir': 'build'} 09:00:12 INFO - ##### 09:00:12 INFO - ##### Running clobber step. 09:00:12 INFO - ##### 09:00:12 INFO - Running pre-action listener: _resource_record_pre_action 09:00:12 INFO - Running main action method: clobber 09:00:12 INFO - rmtree: /builds/slave/test/build 09:00:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:00:13 INFO - Running post-action listener: _resource_record_post_action 09:00:13 INFO - ##### 09:00:13 INFO - ##### Running read-buildbot-config step. 09:00:13 INFO - ##### 09:00:13 INFO - Running pre-action listener: _resource_record_pre_action 09:00:13 INFO - Running main action method: read_buildbot_config 09:00:13 INFO - Using buildbot properties: 09:00:13 INFO - { 09:00:13 INFO - "project": "", 09:00:13 INFO - "product": "firefox", 09:00:13 INFO - "script_repo_revision": "production", 09:00:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:00:13 INFO - "repository": "", 09:00:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:00:13 INFO - "buildid": "20160328080848", 09:00:13 INFO - "pgo_build": "False", 09:00:13 INFO - "basedir": "/builds/slave/test", 09:00:13 INFO - "buildnumber": 2707, 09:00:13 INFO - "slavename": "talos-linux64-ix-065", 09:00:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:00:13 INFO - "platform": "ubuntu64_hw", 09:00:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:00:13 INFO - "branch": "fx-team", 09:00:13 INFO - "repo_path": "integration/fx-team", 09:00:13 INFO - "revision": "334c1b88d28a46e3ebefbd42a55190bee4b3fefc", 09:00:13 INFO - "stage_platform": "linux64", 09:00:13 INFO - "builduid": "432e2e87b9b64c2a902e134a41a0d6e2", 09:00:13 INFO - "slavebuilddir": "test" 09:00:13 INFO - } 09:00:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:00:13 INFO - Running post-action listener: _resource_record_post_action 09:00:13 INFO - ##### 09:00:13 INFO - ##### Running download-and-extract step. 09:00:13 INFO - ##### 09:00:13 INFO - Running pre-action listener: _resource_record_pre_action 09:00:13 INFO - Running main action method: download_and_extract 09:00:13 INFO - mkdir: /builds/slave/test/build/tests 09:00:13 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')]} 09:00:13 INFO - https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:14 INFO - Downloaded 1361 bytes. 09:00:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:00:14 INFO - Using the following test package requirements: 09:00:14 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:00:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:00:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:00:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:14 INFO - u'jsshell-linux-x86_64.zip'], 09:00:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:00:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:00:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:00:14 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:00:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:00:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:00:14 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:00:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:14 INFO - https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:16 INFO - Downloaded 22085590 bytes. 09:00:16 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'] 09:00:16 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 09:00:17 INFO - Return code: 0 09:00:17 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 09:00: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')]} 09:00:17 INFO - https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:30 INFO - Downloaded 22085590 bytes. 09:00:30 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'] 09:00:30 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 09:00:31 INFO - Return code: 0 09:00: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')]} 09:00:31 INFO - https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:00:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:00:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:00:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:37 INFO - Downloaded 10847531 bytes. 09:00:37 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'] 09:00:37 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 09:00:37 INFO - Return code: 0 09:00:37 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')]} 09:00:37 INFO - https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cROxbER1RS-lm5GLshIVgA/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 09:00:41 INFO - Downloaded 54262864 bytes. 09:00:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:41 INFO - mkdir: /builds/slave/test/properties 09:00:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:00:41 INFO - Writing to file /builds/slave/test/properties/build_url 09:00:41 INFO - Contents: 09:00:41 INFO - build_url:https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:00:42 INFO - Running post-action listener: _resource_record_post_action 09:00:42 INFO - Running post-action listener: set_extra_try_arguments 09:00:42 INFO - ##### 09:00:42 INFO - ##### Running populate-webroot step. 09:00:42 INFO - ##### 09:00:42 INFO - Running pre-action listener: _resource_record_pre_action 09:00:42 INFO - Running main action method: populate_webroot 09:00:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:00:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:00:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:00:42 INFO - '--tppagecycles', 09:00:42 INFO - '7'], 09:00:42 INFO - 'tests': ['tsvgm']}}, 09:00:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:00:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:00:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:00:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:00:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:42 INFO - 'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:42 INFO - 'tests': ['damp', 'tps']}, 09:00:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:42 INFO - 'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['damp', 'tps']}, 09:00:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:00:42 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['dromaeo_dom']}, 09:00:42 INFO - 'other': {'tests': ['a11yr', 09:00:42 INFO - 'ts_paint', 09:00:42 INFO - 'tpaint', 09:00:42 INFO - 'sessionrestore', 09:00:42 INFO - 'sessionrestore_no_auto_restore', 09:00:42 INFO - 'tabpaint']}, 09:00:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['a11yr', 09:00:42 INFO - 'ts_paint', 09:00:42 INFO - 'tpaint', 09:00:42 INFO - 'sessionrestore', 09:00:42 INFO - 'sessionrestore_no_auto_restore', 09:00:42 INFO - 'tabpaint']}, 09:00:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['a11yr', 09:00:42 INFO - 'ts_paint', 09:00:42 INFO - 'tpaint', 09:00:42 INFO - 'sessionrestore', 09:00:42 INFO - 'sessionrestore_no_auto_restore', 09:00:42 INFO - 'tabpaint']}, 09:00:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['a11yr', 09:00:42 INFO - 'ts_paint', 09:00:42 INFO - 'tpaint', 09:00:42 INFO - 'sessionrestore', 09:00:42 INFO - 'sessionrestore_no_auto_restore', 09:00:42 INFO - 'tabpaint']}, 09:00:42 INFO - 'other_l64': {'tests': ['a11yr', 09:00:42 INFO - 'ts_paint', 09:00:42 INFO - 'tpaint', 09:00:42 INFO - 'sessionrestore', 09:00:42 INFO - 'sessionrestore_no_auto_restore', 09:00:42 INFO - 'tabpaint']}, 09:00:42 INFO - 'other_nol64': {'tests': ['a11yr', 09:00:42 INFO - 'ts_paint', 09:00:42 INFO - 'tpaint', 09:00:42 INFO - 'sessionrestore', 09:00:42 INFO - 'sessionrestore_no_auto_restore', 09:00:42 INFO - 'tabpaint']}, 09:00:42 INFO - 'svgr': {'tests': ['tsvgx', 09:00:42 INFO - 'tsvgr_opacity', 09:00:42 INFO - 'tart', 09:00:42 INFO - 'tscrollx', 09:00:42 INFO - 'cart']}, 09:00:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['tsvgx', 09:00:42 INFO - 'tsvgr_opacity', 09:00:42 INFO - 'tart', 09:00:42 INFO - 'tscrollx', 09:00:42 INFO - 'cart']}, 09:00:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:42 INFO - 'tests': ['tp5o']}, 09:00:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:42 INFO - 'talos_options': ['--e10s'], 09:00:42 INFO - 'tests': ['tp5o']}, 09:00:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:42 INFO - 'talos_options': ['--xperf_path', 09:00:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:42 INFO - 'tests': ['tp5n']}, 09:00:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:42 INFO - 'talos_options': ['--e10s', 09:00:42 INFO - '--xperf_path', 09:00:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:42 INFO - 'tests': ['tp5n']}}, 09:00:42 INFO - 'talos.zip': {'path': '', 09:00:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:00:42 INFO - Running post-action listener: _resource_record_post_action 09:00:42 INFO - ##### 09:00:42 INFO - ##### Running create-virtualenv step. 09:00:42 INFO - ##### 09:00:42 INFO - Running pre-action listener: _resource_record_pre_action 09:00:42 INFO - Running main action method: create_virtualenv 09:00:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:00:42 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 09:00:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:00:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:00:42 INFO - Using real prefix '/usr' 09:00:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:00:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:00:44 INFO - Installing pip.................done. 09:00:44 INFO - Return code: 0 09:00:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:44 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 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:00:44 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 09:00:44 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 09:00:44 INFO - Using env: {'DISPLAY': ':0', 09:00:44 INFO - 'HOME': '/home/cltbld', 09:00:44 INFO - 'LANG': 'en_US.UTF-8', 09:00:44 INFO - 'LANGUAGE': 'en_US:en', 09:00:44 INFO - 'LOGNAME': 'cltbld', 09:00:44 INFO - 'MAIL': '/var/mail/cltbld', 09:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:44 INFO - 'MOZ_NO_REMOTE': '1', 09:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:44 INFO - 'NO_EM_RESTART': '1', 09:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:44 INFO - 'PWD': '/builds/slave/test', 09:00:44 INFO - 'SHELL': '/bin/bash', 09:00:44 INFO - 'SHLVL': '1', 09:00:44 INFO - 'TERM': 'linux', 09:00:44 INFO - 'TMOUT': '86400', 09:00:44 INFO - 'USER': 'cltbld', 09:00:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:44 INFO - '_': '/tools/buildbot/bin/python'} 09:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:45 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 09:00:45 INFO - Cleaning up... 09:00:45 INFO - Return code: 0 09:00:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:45 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 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:00:45 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 09:00:45 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 09:00:45 INFO - Using env: {'DISPLAY': ':0', 09:00:45 INFO - 'HOME': '/home/cltbld', 09:00:45 INFO - 'LANG': 'en_US.UTF-8', 09:00:45 INFO - 'LANGUAGE': 'en_US:en', 09:00:45 INFO - 'LOGNAME': 'cltbld', 09:00:45 INFO - 'MAIL': '/var/mail/cltbld', 09:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:45 INFO - 'MOZ_NO_REMOTE': '1', 09:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:45 INFO - 'NO_EM_RESTART': '1', 09:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:45 INFO - 'PWD': '/builds/slave/test', 09:00:45 INFO - 'SHELL': '/bin/bash', 09:00:45 INFO - 'SHLVL': '1', 09:00:45 INFO - 'TERM': 'linux', 09:00:45 INFO - 'TMOUT': '86400', 09:00:45 INFO - 'USER': 'cltbld', 09:00:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:45 INFO - '_': '/tools/buildbot/bin/python'} 09:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:45 INFO - Downloading/unpacking psutil>=0.7.1 09:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:48 INFO - Installing collected packages: psutil 09:00:48 INFO - Running setup.py install for psutil 09:00:48 INFO - building 'psutil._psutil_linux' extension 09:00:48 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 09:00:48 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 09:00:48 INFO - building 'psutil._psutil_posix' extension 09:00:48 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 09:00:48 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 09:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:48 INFO - Successfully installed psutil 09:00:48 INFO - Cleaning up... 09:00:48 INFO - Return code: 0 09:00:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:00:48 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')]} 09:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:48 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')]} 09:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:48 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 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:00:48 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 09:00:48 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 09:00:48 INFO - Using env: {'DISPLAY': ':0', 09:00:48 INFO - 'HOME': '/home/cltbld', 09:00:48 INFO - 'LANG': 'en_US.UTF-8', 09:00:48 INFO - 'LANGUAGE': 'en_US:en', 09:00:48 INFO - 'LOGNAME': 'cltbld', 09:00:48 INFO - 'MAIL': '/var/mail/cltbld', 09:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:48 INFO - 'MOZ_NO_REMOTE': '1', 09:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:48 INFO - 'NO_EM_RESTART': '1', 09:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:48 INFO - 'PWD': '/builds/slave/test', 09:00:48 INFO - 'SHELL': '/bin/bash', 09:00:48 INFO - 'SHLVL': '1', 09:00:48 INFO - 'TERM': 'linux', 09:00:48 INFO - 'TMOUT': '86400', 09:00:48 INFO - 'USER': 'cltbld', 09:00:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:48 INFO - '_': '/tools/buildbot/bin/python'} 09:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:00:51 INFO - Installing collected packages: mozsystemmonitor 09:00:51 INFO - Running setup.py install for mozsystemmonitor 09:00:51 INFO - Successfully installed mozsystemmonitor 09:00:51 INFO - Cleaning up... 09:00:51 INFO - Return code: 0 09:00:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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', '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 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:00: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 blobuploader==1.2.4 09:00:51 INFO - Using env: {'DISPLAY': ':0', 09:00:51 INFO - 'HOME': '/home/cltbld', 09:00:51 INFO - 'LANG': 'en_US.UTF-8', 09:00:51 INFO - 'LANGUAGE': 'en_US:en', 09:00:51 INFO - 'LOGNAME': 'cltbld', 09:00:51 INFO - 'MAIL': '/var/mail/cltbld', 09:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:51 INFO - 'MOZ_NO_REMOTE': '1', 09:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:51 INFO - 'NO_EM_RESTART': '1', 09:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:51 INFO - 'PWD': '/builds/slave/test', 09:00:51 INFO - 'SHELL': '/bin/bash', 09:00:51 INFO - 'SHLVL': '1', 09:00:51 INFO - 'TERM': 'linux', 09:00:51 INFO - 'TMOUT': '86400', 09:00:51 INFO - 'USER': 'cltbld', 09:00:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:51 INFO - '_': '/tools/buildbot/bin/python'} 09:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:54 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:55 INFO - Downloading docopt-0.6.1.tar.gz 09:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:55 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:55 INFO - Running setup.py install for blobuploader 09:00:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:55 INFO - Running setup.py install for requests 09:00:55 INFO - Running setup.py install for docopt 09:00:55 INFO - Successfully installed blobuploader requests docopt 09:00:55 INFO - Cleaning up... 09:00:55 INFO - Return code: 0 09:00:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:55 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 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:00:55 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 09:00:55 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 09:00:55 INFO - Using env: {'DISPLAY': ':0', 09:00:55 INFO - 'HOME': '/home/cltbld', 09:00:55 INFO - 'LANG': 'en_US.UTF-8', 09:00:55 INFO - 'LANGUAGE': 'en_US:en', 09:00:55 INFO - 'LOGNAME': 'cltbld', 09:00:55 INFO - 'MAIL': '/var/mail/cltbld', 09:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:55 INFO - 'MOZ_NO_REMOTE': '1', 09:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:55 INFO - 'NO_EM_RESTART': '1', 09:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:55 INFO - 'PWD': '/builds/slave/test', 09:00:55 INFO - 'SHELL': '/bin/bash', 09:00:55 INFO - 'SHLVL': '1', 09:00:55 INFO - 'TERM': 'linux', 09:00:55 INFO - 'TMOUT': '86400', 09:00:55 INFO - 'USER': 'cltbld', 09:00:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:55 INFO - '_': '/tools/buildbot/bin/python'} 09:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:56 INFO - Running setup.py (path:/tmp/pip-jzNvEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:56 INFO - Running setup.py (path:/tmp/pip-UCRIie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:56 INFO - Running setup.py (path:/tmp/pip-pIJ6i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:56 INFO - Running setup.py (path:/tmp/pip-mRX9x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:56 INFO - Running setup.py (path:/tmp/pip-4uStQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:56 INFO - Running setup.py (path:/tmp/pip-3NhoEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:56 INFO - Running setup.py (path:/tmp/pip-jKkeYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:56 INFO - Running setup.py (path:/tmp/pip-hN09ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:56 INFO - Running setup.py (path:/tmp/pip-uzwc3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:56 INFO - Running setup.py (path:/tmp/pip-fk4W_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:56 INFO - Running setup.py (path:/tmp/pip-QY468A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:56 INFO - Running setup.py (path:/tmp/pip-qu1a4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:56 INFO - Running setup.py (path:/tmp/pip-bL8rX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:56 INFO - Running setup.py (path:/tmp/pip-jgE8im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:57 INFO - Running setup.py (path:/tmp/pip-kDw3CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:57 INFO - Running setup.py (path:/tmp/pip-9qNO0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:57 INFO - Running setup.py (path:/tmp/pip-7zwYSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:57 INFO - Running setup.py install for manifestparser 09:00:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:57 INFO - Running setup.py install for mozcrash 09:00:57 INFO - Running setup.py install for mozdebug 09:00:57 INFO - Running setup.py install for mozdevice 09:00:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:00:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:57 INFO - Running setup.py install for mozfile 09:00:57 INFO - Running setup.py install for mozhttpd 09:00:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:57 INFO - Running setup.py install for mozinfo 09:00:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:57 INFO - Running setup.py install for mozInstall 09:00:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Running setup.py install for mozleak 09:00:58 INFO - Running setup.py install for mozlog 09:00:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Running setup.py install for moznetwork 09:00:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Running setup.py install for mozprocess 09:00:58 INFO - Running setup.py install for mozprofile 09:00:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Running setup.py install for mozrunner 09:00:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Running setup.py install for mozscreenshot 09:00:58 INFO - Running setup.py install for moztest 09:00:58 INFO - Running setup.py install for mozversion 09:00:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:00:59 INFO - Cleaning up... 09:00:59 INFO - Return code: 0 09:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:59 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')]} 09:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:59 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')]} 09:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:59 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 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:00:59 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 09:00:59 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 09:00:59 INFO - Using env: {'DISPLAY': ':0', 09:00:59 INFO - 'HOME': '/home/cltbld', 09:00:59 INFO - 'LANG': 'en_US.UTF-8', 09:00:59 INFO - 'LANGUAGE': 'en_US:en', 09:00:59 INFO - 'LOGNAME': 'cltbld', 09:00:59 INFO - 'MAIL': '/var/mail/cltbld', 09:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:59 INFO - 'MOZ_NO_REMOTE': '1', 09:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:59 INFO - 'NO_EM_RESTART': '1', 09:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:59 INFO - 'PWD': '/builds/slave/test', 09:00:59 INFO - 'SHELL': '/bin/bash', 09:00:59 INFO - 'SHLVL': '1', 09:00:59 INFO - 'TERM': 'linux', 09:00:59 INFO - 'TMOUT': '86400', 09:00:59 INFO - 'USER': 'cltbld', 09:00:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:59 INFO - '_': '/tools/buildbot/bin/python'} 09:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:59 INFO - Running setup.py (path:/tmp/pip-Xqc4t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:59 INFO - Running setup.py (path:/tmp/pip-ubYaAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:59 INFO - Running setup.py (path:/tmp/pip-XVMHbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:59 INFO - Running setup.py (path:/tmp/pip-bnYz8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:59 INFO - Running setup.py (path:/tmp/pip-79Mibx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:59 INFO - Running setup.py (path:/tmp/pip-wyeJV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:59 INFO - Running setup.py (path:/tmp/pip-8YQCVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:59 INFO - Running setup.py (path:/tmp/pip-anmrVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:59 INFO - Running setup.py (path:/tmp/pip-s54pYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:59 INFO - Running setup.py (path:/tmp/pip-93CtLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:59 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)) 09:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:59 INFO - Running setup.py (path:/tmp/pip-hUNIiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:00 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)) 09:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:00 INFO - Running setup.py (path:/tmp/pip-E72hUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:00 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)) 09:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:00 INFO - Running setup.py (path:/tmp/pip-Dp8D_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:00 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)) 09:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:00 INFO - Running setup.py (path:/tmp/pip-3f1DQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:00 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)) 09:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:00 INFO - Running setup.py (path:/tmp/pip-CQqhxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:00 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)) 09:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:00 INFO - Running setup.py (path:/tmp/pip-OhpLY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:00 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)) 09:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:00 INFO - Running setup.py (path:/tmp/pip-uRl6Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:00 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)) 09:01:00 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)) 09:01:00 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)) 09:01:00 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)) 09:01:00 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)) 09:01:00 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)) 09:01:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:00 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 09:01:03 INFO - Downloading blessings-1.6.tar.gz 09:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:03 INFO - Installing collected packages: blessings 09:01:03 INFO - Running setup.py install for blessings 09:01:03 INFO - Successfully installed blessings 09:01:03 INFO - Cleaning up... 09:01:03 INFO - Return code: 0 09:01:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:03 INFO - Reading from file tmpfile_stdout 09:01:03 INFO - Current package versions: 09:01:03 INFO - argparse == 1.2.1 09:01:03 INFO - blessings == 1.6 09:01:03 INFO - blobuploader == 1.2.4 09:01:03 INFO - docopt == 0.6.1 09:01:03 INFO - manifestparser == 1.1 09:01:03 INFO - mozInstall == 1.12 09:01:03 INFO - mozcrash == 0.17 09:01:03 INFO - mozdebug == 0.1 09:01:03 INFO - mozdevice == 0.48 09:01:03 INFO - mozfile == 1.2 09:01:03 INFO - mozhttpd == 0.7 09:01:03 INFO - mozinfo == 0.9 09:01:03 INFO - mozleak == 0.1 09:01:03 INFO - mozlog == 3.1 09:01:03 INFO - moznetwork == 0.27 09:01:03 INFO - mozprocess == 0.22 09:01:03 INFO - mozprofile == 0.28 09:01:03 INFO - mozrunner == 6.11 09:01:03 INFO - mozscreenshot == 0.1 09:01:03 INFO - mozsystemmonitor == 0.0 09:01:03 INFO - moztest == 0.7 09:01:03 INFO - mozversion == 1.4 09:01:03 INFO - psutil == 3.1.1 09:01:03 INFO - requests == 1.2.3 09:01:03 INFO - wsgiref == 0.1.2 09:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:03 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')]} 09:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:03 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')]} 09:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:03 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 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:01:03 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 09:01:03 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 09:01:03 INFO - Using env: {'DISPLAY': ':0', 09:01:03 INFO - 'HOME': '/home/cltbld', 09:01:03 INFO - 'LANG': 'en_US.UTF-8', 09:01:03 INFO - 'LANGUAGE': 'en_US:en', 09:01:03 INFO - 'LOGNAME': 'cltbld', 09:01:03 INFO - 'MAIL': '/var/mail/cltbld', 09:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:03 INFO - 'MOZ_NO_REMOTE': '1', 09:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:03 INFO - 'NO_EM_RESTART': '1', 09:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:03 INFO - 'PWD': '/builds/slave/test', 09:01:03 INFO - 'SHELL': '/bin/bash', 09:01:03 INFO - 'SHLVL': '1', 09:01:03 INFO - 'TERM': 'linux', 09:01:03 INFO - 'TMOUT': '86400', 09:01:03 INFO - 'USER': 'cltbld', 09:01:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:03 INFO - '_': '/tools/buildbot/bin/python'} 09:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 INFO - Cleaning up... 09:01:03 INFO - Return code: 0 09:01:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:01:03 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')]} 09:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:03 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')]} 09:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:03 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 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:01:03 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 09:01:03 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 09:01:03 INFO - Using env: {'DISPLAY': ':0', 09:01:03 INFO - 'HOME': '/home/cltbld', 09:01:03 INFO - 'LANG': 'en_US.UTF-8', 09:01:03 INFO - 'LANGUAGE': 'en_US:en', 09:01:03 INFO - 'LOGNAME': 'cltbld', 09:01:03 INFO - 'MAIL': '/var/mail/cltbld', 09:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:03 INFO - 'MOZ_NO_REMOTE': '1', 09:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:03 INFO - 'NO_EM_RESTART': '1', 09:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:03 INFO - 'PWD': '/builds/slave/test', 09:01:03 INFO - 'SHELL': '/bin/bash', 09:01:03 INFO - 'SHLVL': '1', 09:01:03 INFO - 'TERM': 'linux', 09:01:03 INFO - 'TMOUT': '86400', 09:01:03 INFO - 'USER': 'cltbld', 09:01:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:03 INFO - '_': '/tools/buildbot/bin/python'} 09:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:04 INFO - Downloading/unpacking jsonschema 09:01:04 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 09:01:04 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 09:01:04 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 09:01:04 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 09:01:04 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 09:01:04 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 09:01:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:01:06 INFO - Downloading/unpacking functools32 (from jsonschema) 09:01:06 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 09:01:06 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 09:01:06 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 09:01:06 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 09:01:06 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 09:01:06 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 09:01:06 INFO - Downloading functools32-3.2.3-2.tar.gz 09:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:01:07 INFO - warning: no files found matching '*.txt' 09:01:07 INFO - no previously-included directories found matching 'build' 09:01:07 INFO - no previously-included directories found matching 'dist' 09:01:07 INFO - no previously-included directories found matching '.git*' 09:01:07 INFO - Installing collected packages: jsonschema, functools32 09:01:07 INFO - Running setup.py install for functools32 09:01:07 INFO - warning: no files found matching '*.txt' 09:01:07 INFO - no previously-included directories found matching 'build' 09:01:07 INFO - no previously-included directories found matching 'dist' 09:01:07 INFO - no previously-included directories found matching '.git*' 09:01:07 INFO - Successfully installed jsonschema functools32 09:01:07 INFO - Cleaning up... 09:01:07 INFO - Return code: 0 09:01:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57002e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfff5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, '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': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', '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 09:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:01:07 INFO - Using env: {'DISPLAY': ':0', 09:01:07 INFO - 'HOME': '/home/cltbld', 09:01:07 INFO - 'LANG': 'en_US.UTF-8', 09:01:07 INFO - 'LANGUAGE': 'en_US:en', 09:01:07 INFO - 'LOGNAME': 'cltbld', 09:01:07 INFO - 'MAIL': '/var/mail/cltbld', 09:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:07 INFO - 'MOZ_NO_REMOTE': '1', 09:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:07 INFO - 'NO_EM_RESTART': '1', 09:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:07 INFO - 'PWD': '/builds/slave/test', 09:01:07 INFO - 'SHELL': '/bin/bash', 09:01:07 INFO - 'SHLVL': '1', 09:01:07 INFO - 'TERM': 'linux', 09:01:07 INFO - 'TMOUT': '86400', 09:01:07 INFO - 'USER': 'cltbld', 09:01:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:07 INFO - '_': '/tools/buildbot/bin/python'} 09:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:07 INFO - Downloading/unpacking flake8 09:01:07 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 09:01:07 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 09:01:07 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 09:01:07 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 09:01:07 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 09:01:07 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 09:01:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:01:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:01:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:09 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 09:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:01:10 INFO - no previously-included directories found matching 'docs/_build' 09:01:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:01:10 INFO - Running setup.py install for pep8 09:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:01:10 INFO - no previously-included directories found matching 'docs/_build' 09:01:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:01:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:01:10 INFO - Cleaning up... 09:01:10 INFO - Return code: 0 09:01:10 INFO - Running post-action listener: _resource_record_post_action 09:01:10 INFO - Running post-action listener: _start_resource_monitoring 09:01:10 INFO - Starting resource monitoring. 09:01:10 INFO - ##### 09:01:10 INFO - ##### Running install step. 09:01:10 INFO - ##### 09:01:10 INFO - Running pre-action listener: _resource_record_pre_action 09:01:10 INFO - Running main action method: install 09:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:10 INFO - Reading from file tmpfile_stdout 09:01:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:10 INFO - Reading from file tmpfile_stdout 09:01:10 INFO - Output received: 09:01:10 INFO - Usage: mozinstall [options] installer 09:01:10 INFO - Options: 09:01:10 INFO - -h, --help show this help message and exit 09:01:10 INFO - -d DEST, --destination=DEST 09:01:10 INFO - Directory to install application into. [default: 09:01:10 INFO - "/builds/slave/test"] 09:01:10 INFO - --app=APP Application being installed. [default: firefox] 09:01:10 INFO - mkdir: /builds/slave/test/build/application 09:01:10 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'] 09:01:10 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 09:01:26 INFO - Reading from file tmpfile_stdout 09:01:26 INFO - Output received: 09:01:26 INFO - /builds/slave/test/build/application/firefox/firefox 09:01:26 INFO - Running post-action listener: _resource_record_post_action 09:01:26 INFO - ##### 09:01:26 INFO - ##### Running run-tests step. 09:01:26 INFO - ##### 09:01:26 INFO - Running pre-action listener: _resource_record_pre_action 09:01:26 INFO - Running main action method: run_tests 09:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:26 INFO - Python 2.7.3 09:01:26 INFO - Return code: 0 09:01:26 INFO - grabbing minidump binary from tooltool 09:01:26 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')]} 09:01:26 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 0x108e410>, '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 0x108f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:26 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 09:01:26 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 09:01:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:26 INFO - Return code: 0 09:01:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:01:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:01:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:01:27 INFO - Return code: 0 09:01:27 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/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:01:27 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/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 09:01:27 INFO - Using env: {'DISPLAY': ':0', 09:01:27 INFO - 'HOME': '/home/cltbld', 09:01:27 INFO - 'LANG': 'en_US.UTF-8', 09:01:27 INFO - 'LANGUAGE': 'en_US:en', 09:01:27 INFO - 'LOGNAME': 'cltbld', 09:01:27 INFO - 'MAIL': '/var/mail/cltbld', 09:01:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:27 INFO - 'MOZ_NO_REMOTE': '1', 09:01:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:27 INFO - 'NO_EM_RESTART': '1', 09:01:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:27 INFO - 'PWD': '/builds/slave/test', 09:01:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:27 INFO - 'SHELL': '/bin/bash', 09:01:27 INFO - 'SHLVL': '1', 09:01:27 INFO - 'TERM': 'linux', 09:01:27 INFO - 'TMOUT': '86400', 09:01:27 INFO - 'USER': 'cltbld', 09:01:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660', 09:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:27 INFO - '_': '/tools/buildbot/bin/python'} 09:01:27 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/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:01:27 INFO - mozversion application_buildid: 20160328080848 09:01:27 INFO - mozversion application_changeset: 334c1b88d28a46e3ebefbd42a55190bee4b3fefc 09:01:27 INFO - mozversion application_display_name: Nightly 09:01:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:27 INFO - mozversion application_name: Firefox 09:01:27 INFO - mozversion application_remotingname: firefox 09:01:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:01:27 INFO - mozversion application_vendor: Mozilla 09:01:27 INFO - mozversion application_version: 48.0a1 09:01:27 INFO - mozversion platform_buildid: 20160328080848 09:01:27 INFO - mozversion platform_changeset: 334c1b88d28a46e3ebefbd42a55190bee4b3fefc 09:01:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:01:27 INFO - mozversion platform_version: 48.0a1 09:01:27 INFO - using testdate: 1459180887 09:01:27 INFO - actual date: 1459180887 09:01:27 INFO - starting webserver on 'localhost:54971' 09:01:27 INFO - SUITE-START | Running 2 tests 09:01:27 INFO - TEST-START | dromaeo_css 09:01:27 INFO - operating with platform_type : linux_ 09:01:27 INFO - Initialising browser for dromaeo_css test... 09:01:27 INFO - TEST-INFO | started process 13399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP9YpwK/profile http://localhost:54971/getInfo.html) 09:01:31 INFO - PROCESS | 13399 | __metrics Screen width/height:1600/1200 09:01:31 INFO - PROCESS | 13399 | colorDepth:24 09:01:31 INFO - PROCESS | 13399 | Browser inner width/height: 1024/697 09:01:31 INFO - PROCESS | 13399 | __metrics 09:01:32 ERROR - PROCESS | 13399 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:01:33 INFO - TEST-INFO | 13399: exit 0 09:01:33 INFO - Browser initialized. 09:01:33 INFO - Running cycle 1/1 for dromaeo_css test... 09:01:33 INFO - TEST-INFO | started process 13491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP9YpwK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:45 INFO - PROCESS | 13491 | RSS: Main: 155058176 09:01:45 INFO - PROCESS | 13491 | 09:02:36 INFO - PROCESS | 13491 | 1459180956789 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] 09:04:48 INFO - PROCESS | 13491 | Cycle 1(1): loaded http://localhost:54971/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54971/tests/dromaeo/cssquery-ext.html) 09:04:49 INFO - PROCESS | 13491 | RSS: Main: 264142848 09:04:49 INFO - PROCESS | 13491 | 09:07:51 INFO - PROCESS | 13491 | Cycle 1(1): loaded http://localhost:54971/tests/dromaeo/cssquery-ext.html (next: http://localhost:54971/tests/dromaeo/cssquery-jquery.html) 09:07:52 INFO - PROCESS | 13491 | RSS: Main: 242298880 09:07:52 INFO - PROCESS | 13491 | 09:10:54 INFO - PROCESS | 13491 | Cycle 1(1): loaded http://localhost:54971/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54971/tests/dromaeo/cssquery-mootools.html) 09:10:55 INFO - PROCESS | 13491 | RSS: Main: 237445120 09:10:55 INFO - PROCESS | 13491 | 09:13:56 INFO - PROCESS | 13491 | Cycle 1(1): loaded http://localhost:54971/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54971/tests/dromaeo/cssquery-prototype.html) 09:13:57 INFO - PROCESS | 13491 | RSS: Main: 210649088 09:13:57 INFO - PROCESS | 13491 | 09:17:00 INFO - PROCESS | 13491 | Cycle 1(1): loaded http://localhost:54971/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54971/tests/dromaeo/cssquery-yui.html) 09:17:00 INFO - PROCESS | 13491 | RSS: Main: 203825152 09:17:00 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | Cycle 1(1): loaded http://localhost:54971/tests/dromaeo/cssquery-yui.html (next: http://localhost:54971/tests/dromaeo/cssquery-dojo.html) 09:20:03 INFO - PROCESS | 13491 | RSS: Main: 271958016 09:20:03 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | __start_tp_report 09:20:03 INFO - PROCESS | 13491 | _x_x_mozilla_page_load 09:20:03 INFO - PROCESS | 13491 | _x_x_mozilla_page_load_details 09:20:03 INFO - PROCESS | 13491 | |i|pagename|runs| 09:20:03 INFO - PROCESS | 13491 | |0;dojo.html;2579.9226023219303;2655.3361659585103;2657.4020845309797;2667.0665267156496;2681.4368982513665;4599.149157405882;4644.674872758904;4675;4692.038132182907;4706.69406488578;4663.790129444174;4687.90624187516;4693.413323334583;4759.333693282934;4759.833405830796;4272.337787642905;4305.268104422255;4308.633766129883;4319.179355922381;4428.579284967939;4380.912381752363;4381.956180438203;4386.188555117314;4386.605205531501;4399.03221291317;4254.361845723135;4326.221280169569;4328.61042506176;4331.566843315674;4367.672424568138;4275.0594869128745;4292.871213863558;4305.440292761952;4344.23975804233;4374.825006999717;4260.062786187033;4265.104328091104;4267.274563324242;4293.656507479425;4311.698181127323;4467.15124126415;4507.932381014288;4567.451905771295;4570.314452832102;4625.398698169251;5058.266551350033;5061.114304996611;5064.290999260106;5087.109755792759;5109.540141387293;5100.28595996557;5111.897762044776;5124.846254612367;5125.487451254882;5183.429822719498;4529.977350113229;4685.67200295976;4741.122892264942;4750.4299484061785;4770.713757174512;5136.8715782105;5143.27994080829;5171.3535808024;5172.767225474862;5194.246834209019;4929.876753081202;4932.975335123373;4935.432425271139;4936.506349365035;4986.15235409974;4932.580730637936;4983.302337672729;4985.252212168204;4989.600831933437;5002.274670172877;5059.06407314648;5059.19052951526;5059.72171530562;5060.49395060491;5104.1578139606545;5021.5229553192385;5041.546260836542;5043.3191519145175;5048.7728052237735;5098.337216161949;4193.853215137517;4272.636825869836;4276.273033584298;4302.032042790347;4369.235383807821;3721.813909304524;3746.587875333711;3750.1749615084636;3781.3382658034734;3807.3908174691915;4341.327094300388;4363.563643635611;4364.258076127066;4365;4405.515393306734;4965.3048573199785;5044.1929291313945;5112.948870511322;5122.334096567422;5149.356330458692;4355.455568053993;4374.737515749001;4394.560543945644;4418.182636212311;4422.933655995163;4627.190241707755;4629.8148074077335;4630.282306242538;4663.930041049387;4684.8360307389075;4598;4706.987997580537;4724.811007559659;4762.333273341735;4772.498887616889;5107.080725469303;5116.923246151385;5119.283300337881;5127.974360128175;5163.8192663256605;4728.3380326753595;4748.691335063209;4756.738379389167;4757.333973243818;4798.760061996816;4828.5412885775795;4849.612031037438;4886.486918873467;5007.098722230034;5067.493250674903;5044.924326135184;5060.898782024413;5075.7969681212335;5076.619253555924;5093.719845408538;4872.537108974641;4882.536159064884;4887.511248875084;4888.560029597354;4893.192623217129;4821.156297647968;4898.559129678346;4946.505349465025;4983.202687570117;4999.625028122832;4799.3760811094335;4827.179379505422;4831.758412079312;4832.95167048325;4841.806327746992;4906.509349065065;4909.95090049095;4910.140725372974;4920.065187614485;4966.031623833463;4694.812207511662;4749.168895443353;4835.178019736582;4840.757962101951;4843.733594652187 09:20:03 INFO - PROCESS | 13491 | |1;ext.html;535.799075346745;538.3754844380518;562.0501352713914;563.8646724786053;575.9769609215632;27640.723592764065;35277;36082.63917360829;36180.45729314056;36212.81893590535;38396.232075358545;38695.613043869555;38771.22457550847;38811.41782873259;38873;7753.379729621617;7936.563489008102;7940.880886786703;7948.7217947371855;7960.522368657899;7741.612919354038;7827.099883513412;7835.412344074189;7838.412119091063;8064.233897779702;8012.158723334053;8081.5555144467035;8085.191480851927;8090.757277281661;8093.514389136671;7996.600169991477;8069.878951815727;8070.798230044237;8075.636596353149;8081.353491720707;8009.759707208793;8121.75634730959;8128.065272493621;8130.959345203295;8136.837263254761;39507;39608.20783584341;39910.60089399098;39911;39969.80015099906;2936.4420760055523;3092.273315770792;3344.8494817733263;3830.8467661293516;3889.436031775405;29679.406411871856;29917.25206869824;30006.699933000607;30050.84974575135;30300.696993030007;3446.4485682290715;3494.8427320770625;3538.840752166133;3615.2950174715943;3643.981780091109;234256;236014;236106;236571;237854;42939;43902.12195756067;50224.48428609962;50880.49119508832;51363.743181283855;44617.330740038924;44883.55116448794;44887;44952.3257151143;45024.3246351305;13713.657158571115;13860.099093559089;13867;13871.306434678225;13875.861241387456;10200.234982376203;10200.642977495752;10201.336913100624;10218.080372766486;10223.182145428347;14902.329395177243;14966.17686027279;14975.1014939104;15021.098734075991;15141.318640660977;5678.261825962599;5899.911501327483;5913.970430147821;5922.703864806828;5924.259467566554;883.7702197428715;904.3217586809892;907.945523268606;932.8414169591185;993.7366597851575;27018.5947210792;27697.584536231974;27971.44057118846;28216.43567128646;28216.8589157057;1016.5019140621042;1039.3400190878695;1044.2690116918188;1102.6416414665266;1122.6014764758393;13941.651458713613;14483.637909052359;14631.990784874577;14722;14731.116133032052;272127;275063;275613;276026;276311;48113;48515.75742121267;48742.75628621834;48789.5121048785;48871;1079.611339917629;1178.976420471603;1244.6577191272472;1254.5170109507906;1271.205496564647;24089.382588478624;27615.44769104647;27833.44333113367;28087.859560702884;28139.43721125607;38788.6121138785;39157.8042109799;39555.2088958225;39654.603453965094;39657.80171099126;170238;171503;171673;171715;171721.1413942972;27065.323366915985;31016;31343;31343.529847051857;32430.189245269055;33665;35687.464688029184;39620.405693914036;39866;39966.400503991885;32866.1783455406;33331.50002750009;33985.15037124092;34295;34414.655853441145;33493;34008.48987265144;34208.82895585506;34253.828730856185;34509.827450862584;33604.83197583997;34342.65657343494;34456.31087378289;34703.4794478078;34773.47839782355;28533;28715.13854584366;30545.847270763505;30584.84707576448;30901.227469312547;24364;24382.87808560946;24525.141620043927;24599.38501537476;24735.87632061828 09:20:03 INFO - PROCESS | 13491 | |2;jquery.html;352.94176460883966;354.2242488949201;355.34616305996974;357.3710269924931;366.7799320407754;15439.45961891334;15750;16266.349346026145;16707.331706731715;16807.66384672306;14265.92867035666;14379.281035948214;16396.26216820243;16398.26207820648;16579.91710041451;4880.389951256093;4914.680545764531;5051.696898186102;5077.898442031157;5130.333056702642;4975.303457515951;5057.342545469102;5082.339295891547;5098.439171691111;5098.43917169113;5041.596672266228;5044.545990860822;5057.367829021372;5061.44324124346;5064.417591976933;5479.972600136994;5679.091345384719;5699.715014249271;5704.258446401941;5712.971435142818;5058.266551350033;5058.848234552933;5077.771500282459;5079.339685840817;5082.517160869711;11519.078473722082;11547.595834145848;11547.884521154765;11557.653270401901;11799.469023893946;1888.726134710473;1935.525796179931;2049.3954283486405;2121.2999710095787;2121.469632591852;8732.650693972233;8796.69211577598;8872.73381798547;8898.555072246427;10879;1731.6017316017387;1759.8064212936567;1767.5757818123686;1780.6794776940146;1837.5222442165;40064.59935400667;53858.19212711813;54435.99999999961;57099;61075.69462152705;8876.068012858686;9344.906550934404;9352.438853668802;9439.952800235955;9677.322587418954;11947.701307467383;12255.877441225473;12303.507859685691;12348.012159027436;12471.812922806164;6785.626790526569;6859.07402500666;6909.378155965987;7021;7167.498275120692;6358.300586935434;6448.387403196689;6716.126903502513;6910.136232970879;6994.68523916425;4131.731437456556;4291.034517233597;4313.245182093121;4322.351647252937;4362.105768317488;1723.1814887928133;1730.316524972654;1742.451127894709;1762.3038899634828;1783.3134243316417;869.3306154261184;882.5102068352127;905.7554460295684;919.632147141149;928.331601247101;15850.920745396199;16101.67796644084;16121.919390402973;16408;16774.49676509707;852.5140669818144;874.5933141089424;890.9777255568533;899.9965038981488;905.2622112977901;7582.393408527305;9152.130547597968;9153.908460915438;9690.235891907041;9725.61097556104;382415;382679;411734;415851;421077;45357.773211134394;45484.09031819411;66386.00420993689;67354.32645673578;75306;956.9043095690375;969.069693094623;972.4262685015875;987.8863930648067;992.4591097851544;15006.849931500981;15171.468998584996;15322.923385383448;15409.075455472708;15653.21733913277;23439.29682109471;29434;34104;34201.97394078182;34965.300693986486;46160.30759538677;48544;48599.75700121477;48649.513504865914;49464;7193.568385896863;7323.707051717872;7497.137829149718;7574.924250757422;7616.619169041415;9357.298202634693;11723.531058757895;11752.529898804294;11767;11797.52809887595;10074.798504030025;10161.898381016095;10202.38785672862;10226.41490568963;10344.741381465223;6772.390484856386;9923.1069203772;9966.252531060345;10171.23715721309;10452.216083793897;9467.242620590474;9498.905010949802;10114.342567733074;10580.41807700584;10581.259311848406;6915.170179578483;7055.153381594037;7096;7257.491975561871;7281.1262648482525;7378.815529611803;9490.098440648128;9725.124738773544;9773.267004974514;10179.338343007681 09:20:03 INFO - PROCESS | 13491 | |3;mootools.html;1319.4260496683949;1446.8625480579342;1459.2849503743162;1592.4585640882099;1775.937842175524;7125.180604230515;7297.744578939738;7301.488895777285;7312.159101703306;7331.670074846638;7319.451041171907;7488.288612581796;7498.100227972651;7502.249775022495;7513.0233069701;2176.379731776444;2190.0692205812547;2198.318521258407;2198.5712786006734;2201.856879302848;2237.7090978172896;2259.7740225977436;2306.7923886850263;2323.3959170615594;2324.500232450023;2269.534745377202;2281.577908087001;2292.518571100071;2299.1033496936125;2303.1248125712204;2242.9102835886547;2249.3814201094665;2259.4916143867663;2260.378395941113;2261.3555136786017;2293.896774645145;2302.5279817637343;2310.353101131686;2313.8958746856433;2315.9652605210767;7708.922910770877;7737.806554836118;7741.806454838674;7753.883691744629;7759.7672069838;4505.639548836085;4579.152856721517;4587.357769912215;4588.49526552079;4635.2120139576355;3037.8936737214312;3052.145399288203;3154.6056742907135;3170.9048728538182;3178.141901686555;1022.258862324816;1036.4765793274348;1039.3348257115451;1047.9790404191874;1053.1890444357878;10330.89669103307;10388.376697398106;10392.06471417576;10414.323069000491;10422;4193.559676233952;4259.190753756776;4273.209456250604;4293.849715259951;4299.398084268205;8501.48991060526;8553.95723021381;8566.61450234741;8574.314054875595;8575.399722019523;4550.931736023962;4636.095961287584;4643.582077613031;4651.186042442559;4673.836415725434;3688.7602305850032;4023.597640235953;4189.4344263524035;4229.281022226229;4232.449781528443;3589.1565482111682;3615;3651.7626354286886;3683.723720720957;3686.060054686038;1164.9941750291193;1172.4255114993591;1200.2678366196612;1215.769003889258;1218.2446882932638;921.999630401009;933.5518950903469;996.3573495095623;1040.7450174707094;1066.6799960011965;6983.266756990544;7061.505694601328;7104;7106.7157313706875;7127.89308160378;1044.566504900473;1053.9894601054045;1055.3245922609535;1056.1286938275953;1086.3807629651023;5259.658122222043;5337.6797392156595;5365.8390248291835;5365.865853353697;5380.704061276589;9103.49930753815;9267.44395336282;9481.24150067993;9503;9610.807783844424;9333.719988400358;9353.625854965861;9387.249020078378;9426.104520070583;9502.192313653279;7118.466115041392;7261.8547629047125;7285.927140728631;7339.669714862844;7353;7018.75434359795;7052.753153639598;7064.32888875556;7093.467989900882;7136.4647651427385;8289.668413263402;8447.239748422671;8452.239298462922;8634.654613815377;8638.308935285288;8517.23344898962;8711.303095752199;8721.520316382659;8840.690575829814;8892.244159246537;6371.426571608392;6523.18460192476;6547.312532184243;6553.967230163818;6645.734170633121;7056.576605403692;7102.751403700846;7118.537295075804;7123.465740069619;7155.3202445767565;6252.406021427957;6348.301686814354;6352.872942541031;6455.580387274812;6488;6180.536459765445;6279.277883043508;6284;6285.622862628257;6327.11420401135;6621.073049773132;6637.53537252407;6650.9667451662435;6686.899696504459;6688.130543029375;6119.418655227746;6124.928137575996;6125.601835880653;6146.600470969552;6148.354422785543;6451.258105317948;6457.0637257596445;6503.349665033459;6505.707243173973;6522.15212022434 09:20:03 INFO - PROCESS | 13491 | |4;prototype.html;311.7007672634271;314.3791012749819;319.3724331688233;319.60847961247475;320.4184405304374;5257.553107985821;5364.758585863636;5434.809781657638;5456.699881506515;5476.616636835423;5290.259363689077;5362.678239305635;5373;5382.2195781611645;5382.9730851345785;3961.861334853281;4071.5928407159345;4133.2353514599745;4158.147579746144;4194.119234960662;4151.626353628173;4160.625543701066;4169.9791501042455;4181.665466762652;4184.644305234059;4152.709310348277;4154.31453810121;4159.604837540429;4162.354835000579;4173.4157217989505;3910.863119790808;4017.1965606878593;4085.468889044435;4088.693347998912;4095.4675892133832;3567.928641427183;3570.6429357064344;3574.249407624402;3574.5531808523933;3578.8926332209817;5175.637705360627;5182.067227898977;5192.454792246797;5195.610329225323;5197.246399272122;4717.834875779331;4726.0784147091335;4727.95272047282;4732.881677958078;4737.50256223095;5640.717964101819;5657.462541058593;5658.038133517271;5664.773409063632;5669.489745922887;3917.5298964124486;3924.7841368724708;3925.21495700861;3925.391564307537;3926.1362500249897;5723.685197314146;5991.580589358747;5994.580379373446;6015.849603759941;6066.302375226817;3939.468171796828;3985.1830374773103;3985.20295940813;3987.601239876047;3992.121733218687;4040.8585699500377;4054.1486287879284;4054.5742697016976;4058.6955978301744;4061.3501839705505;4699.660596729984;4702.811887524529;4704.623630109583;4705.435347758291;4707.435107787088;5703.144528320702;5708.31500219968;5720.713964301768;5721.084626459747;5723.112917497794;1395.386030146732;1398.7692030815006;1398.9580312590638;1401.7336706026026;1403.0809819568199;879.8900137482815;929.9070092990647;936.6019441737235;959.5490119643756;965.3339195954769;4871.439784424837;4897.8285759998225;4929.137400954819;4930.728809915489;4939.234418665113;5852.385499522574;5869.325027621878;5872;5875;5877.089051197071;4919.409670839522;4925.729084900293;4932.679375840559;4934.481879402683;4939.5554400104165;3116.2676770958806;3148.0870547541413;3151.527270909382;3161.9525707114412;3165.778395512292;5421.728913554307;5424.728763561806;5433.728313584305;5435.755391007414;5436.3476382834315;5785.247917770663;6026.608270462493;6043.7280322385595;6049.213602231682;6052.243469566304;5393.703346315911;5411.540019098342;5419.566434685137;5422.240886275925;5424.755885985219;5807.94192058074;5823.70881455934;5827.096799996008;5830.358660547252;5839.065749480063;5763.394843541368;5780.884382312414;5784.045632470596;5787.189793429007;5787.594868359343;5386.165144402624;5391.919121213106;5392.676439413491;5396.1366181410785;5397.325334333208;3898.4737060497605;4032.979835100923;4034.213328401051;4035.6569691576547;4037.0714735610386;5787.421257874179;5792;5796.333421656564;5800.883982320245;5804.419558044162;5584.46947539983;5588.552915766811;5593.664380137205;5600.299962504687;5607.831765047055;5531.751071201725;5534.972325138348;5542.584306177134;5546.057170280981;5607.859803504945;5299.258103865539;5450.536704380013;5457.61796674229;5458.61789674719;5466.562674986071;5640.323161220515;5643.238162847963;5646.265985421869;5650.886982260414;5652.406497317723;5473.589480788877;5483.698396588226;5515.062439385234;5515.558755299486;5523.922835047128 09:20:03 INFO - PROCESS | 13491 | |5;yui.html;695.7564852301695;730.0254160695471;742.1835980421537;754.2419868032626;769.4190885881159;12140.210886292385;12396.81404778928;12428.13003089784;12470.688232794184;12479.064070194727;12267.877321226784;12308.384580770948;12312.815307770368;13383.59849204523;13907.165570065803;649.2987573420718;798.7963069417304;811.2820154163578;811.4928169893816;811.8498077855586;807.1202389395557;818.5129847740615;824.7525742277322;827.0447632983883;829.0465964141256;853.4665833853842;854.2311919272643;854.3891117850735;855.1875718067829;855.2901092093548;670.8993650952348;679.7722762874444;845.9873101903477;846.7502086884354;847.1316900177337;609.0590038390696;622.953278504114;624.4380057947837;624.7750809708501;624.8594066335083;12637.178583392142;12735.681607959783;12777.552785652457;12792.296423696693;12826.294553799537;11541.422928853524;11890.702732431759;11898.881011189951;12022.218555793845;12178.391080445943;9699.757506062335;9792.755181120458;9896.406215627085;9970.20238380935;10437.79124417515;3187.235063584746;3234.045956442855;3258.8696452141885;3299.6205436374644;3311.1887587540964;42253.36619950703;42358.78820605908;42989;43178.35232471515;43180.78409607963;9639.807203855884;9823.36148150368;9906.950465247628;10018.883812238058;10085.949570252102;16967.915160424367;16969.0667013313;17075.65848683044;17215.65568688619;17222.397216097375;6410.23077230726;6430.7106180222;6542.378474044958;6568.573042752206;6968.3728464438445;3865.6714179295077;3905.3165696003653;3906.8437262509183;3915.941260881089;3949.486566746362;2874.9137525874257;2893.045295052628;2901.0716570697596;2902.782291328159;2909.5199292116986;537.6317222702461;539.91631297149;547.6932917566176;551.2392897801009;560.4983539731917;501.4208589079619;508.57279884896127;636.7484843486797;640.401224854753;645.2289514030688;7931.246531579491;8132.959335203286;8209.58952052395;8303.95848020756;8326.66693332272;469.926218590519;578.3551340255585;611.8286879673699;615.0804547201961;644.4554351573007;3713.313037088147;3720.4233343831747;3745.7190710696805;3783.1677031053123;3842.7886466244067;48890.511094889305;49677;50153.49846501561;50559;50726.74636626867;41367.379489307685;42084;42361.788191059466;42397.788011060366;45214.773926130816;39737.80131099384;40317.79841100834;40426.59573404287;40758.388624170664;41197.38203926943;7906.960465197637;8058.959705201437;8170.754877353689;8218.917810822055;8224.971878515185;30899.227519312197;31293;31981.6801831988;32071.198220043752;32425.189370265933;37436;37853.242935140595;39570;40491.19017619572;40781.59218407897;10091.495425228855;10245.026722461354;10279.383237005804;10518.526666299882;10542.314749541256;10735.892641073802;10819.783604328028;10980;11071.723206919569;11764.823527647264;10915.563377464812;11245.156613254203;11266.042386397248;11552.59565915189;11732.648020559396;10169.644062457779;10292.125169360688;10579.576816927236;10654.786904262026;11084.61203857861;10082.29423940317;10507.579696812347;10537.89462105369;10695.786084278427;10720.142388608736;9445.622175112918;9497.667581634609;9789.510524473606;9797.671909263012;9798.85301720489;9045.728628141167;9368.95315523418;9403.247740180632;9419.199368053793;9577.569009394734 09:20:03 INFO - PROCESS | 13491 | __end_tp_report 09:20:03 INFO - PROCESS | 13491 | __start_cc_report 09:20:03 INFO - PROCESS | 13491 | _x_x_mozilla_cycle_collect,1007 09:20:03 INFO - PROCESS | 13491 | __end_cc_report 09:20:03 INFO - PROCESS | 13491 | __startTimestamp1459182003819__endTimestamp 09:20:03 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | ------- Summary: start ------- 09:20:03 INFO - PROCESS | 13491 | Number of tests: 6 09:20:03 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | [#0] dojo.html Cycles:165 Average:4660.50 Median:4759.83 stddev:488.31 (10.3%) stddev-sans-first:461.73 09:20:03 INFO - PROCESS | 13491 | Values: 2579.9 2655.3 2657.4 2667.1 2681.4 4599.1 4644.7 4675.0 4692.0 4706.7 4663.8 4687.9 4693.4 4759.3 4759.8 4272.3 4305.3 4308.6 4319.2 4428.6 4380.9 4382.0 4386.2 4386.6 4399.0 4254.4 4326.2 4328.6 4331.6 4367.7 4275.1 4292.9 4305.4 4344.2 4374.8 4260.1 4265.1 4267.3 4293.7 4311.7 4467.2 4507.9 4567.5 4570.3 4625.4 5058.3 5061.1 5064.3 5087.1 5109.5 5100.3 5111.9 5124.8 5125.5 5183.4 4530.0 4685.7 4741.1 4750.4 4770.7 5136.9 5143.3 5171.4 5172.8 5194.2 4929.9 4933.0 4935.4 4936.5 4986.2 4932.6 4983.3 4985.3 4989.6 5002.3 5059.1 5059.2 5059.7 5060.5 5104.2 5021.5 5041.5 5043.3 5048.8 5098.3 4193.9 4272.6 4276.3 4302.0 4369.2 3721.8 3746.6 3750.2 3781.3 3807.4 4341.3 4363.6 4364.3 4365.0 4405.5 4965.3 5044.2 5112.9 5122.3 5149.4 4355.5 4374.7 4394.6 4418.2 4422.9 4627.2 4629.8 4630.3 4663.9 4684.8 4598.0 4707.0 4724.8 4762.3 4772.5 5107.1 5116.9 5119.3 5128.0 5163.8 4728.3 4748.7 4756.7 4757.3 4798.8 4828.5 4849.6 4886.5 5007.1 5067.5 5044.9 5060.9 5075.8 5076.6 5093.7 4872.5 4882.5 4887.5 4888.6 4893.2 4821.2 4898.6 4946.5 4983.2 4999.6 4799.4 4827.2 4831.8 4833.0 4841.8 4906.5 4910.0 4910.1 4920.1 4966.0 4694.8 4749.2 4835.2 4840.8 4843.7 09:20:03 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | [#1] ext.html Cycles:180 Average:38782.46 Median:34435.48 stddev:60263.82 (175.0%) stddev-sans-first:60364.45 09:20:03 INFO - PROCESS | 13491 | Values: 535.8 538.4 562.1 563.9 576.0 27640.7 35277.0 36082.6 36180.5 36212.8 38396.2 38695.6 38771.2 38811.4 38873.0 7753.4 7936.6 7940.9 7948.7 7960.5 7741.6 7827.1 7835.4 7838.4 8064.2 8012.2 8081.6 8085.2 8090.8 8093.5 7996.6 8069.9 8070.8 8075.6 8081.4 8009.8 8121.8 8128.1 8131.0 8136.8 39507.0 39608.2 39910.6 39911.0 39969.8 2936.4 3092.3 3344.8 3830.8 3889.4 29679.4 29917.3 30006.7 30050.8 30300.7 3446.4 3494.8 3538.8 3615.3 3644.0 234256.0 236014.0 236106.0 236571.0 237854.0 42939.0 43902.1 50224.5 50880.5 51363.7 44617.3 44883.6 44887.0 44952.3 45024.3 13713.7 13860.1 13867.0 13871.3 13875.9 10200.2 10200.6 10201.3 10218.1 10223.2 14902.3 14966.2 14975.1 15021.1 15141.3 5678.3 5899.9 5914.0 5922.7 5924.3 883.8 904.3 907.9 932.8 993.7 27018.6 27697.6 27971.4 28216.4 28216.9 1016.5 1039.3 1044.3 1102.6 1122.6 13941.7 14483.6 14632.0 14722.0 14731.1 272127.0 275063.0 275613.0 276026.0 276311.0 48113.0 48515.8 48742.8 48789.5 48871.0 1079.6 1179.0 1244.7 1254.5 1271.2 24089.4 27615.4 27833.4 28087.9 28139.4 38788.6 39157.8 39555.2 39654.6 39657.8 170238.0 171503.0 171673.0 171715.0 171721.1 27065.3 31016.0 31343.0 31343.5 32430.2 33665.0 35687.5 39620.4 39866.0 39966.4 32866.2 33331.5 33985.2 34295.0 34414.7 33493.0 34008.5 34208.8 34253.8 34509.8 33604.8 34342.7 34456.3 34703.5 34773.5 28533.0 28715.1 30545.8 30584.8 30901.2 24364.0 24382.9 24525.1 24599.4 24735.9 09:20:03 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | [#2] jquery.html Cycles:180 Average:22991.70 Median:27219.65 stddev:65979.87 (242.4%) stddev-sans-first:66143.06 09:20:03 INFO - PROCESS | 13491 | Values: 352.9 354.2 355.3 357.4 366.8 15439.5 15750.0 16266.3 16707.3 16807.7 14265.9 14379.3 16396.3 16398.3 16579.9 4880.4 4914.7 5051.7 5077.9 5130.3 4975.3 5057.3 5082.3 5098.4 5098.4 5041.6 5044.5 5057.4 5061.4 5064.4 5480.0 5679.1 5699.7 5704.3 5713.0 5058.3 5058.8 5077.8 5079.3 5082.5 11519.1 11547.6 11547.9 11557.7 11799.5 1888.7 1935.5 2049.4 2121.3 2121.5 8732.7 8796.7 8872.7 8898.6 10879.0 1731.6 1759.8 1767.6 1780.7 1837.5 40064.6 53858.2 54436.0 57099.0 61075.7 8876.1 9344.9 9352.4 9440.0 9677.3 11947.7 12255.9 12303.5 12348.0 12471.8 6785.6 6859.1 6909.4 7021.0 7167.5 6358.3 6448.4 6716.1 6910.1 6994.7 4131.7 4291.0 4313.2 4322.4 4362.1 1723.2 1730.3 1742.5 1762.3 1783.3 869.3 882.5 905.8 919.6 928.3 15850.9 16101.7 16121.9 16408.0 16774.5 852.5 874.6 891.0 900.0 905.3 7582.4 9152.1 9153.9 9690.2 9725.6 382415.0 382679.0 411734.0 415851.0 421077.0 45357.8 45484.1 66386.0 67354.3 75306.0 956.9 969.1 972.4 987.9 992.5 15006.8 15171.5 15322.9 15409.1 15653.2 23439.3 29434.0 34104.0 34202.0 34965.3 46160.3 48544.0 48599.8 48649.5 49464.0 7193.6 7323.7 7497.1 7574.9 7616.6 9357.3 11723.5 11752.5 11767.0 11797.5 10074.8 10161.9 10202.4 10226.4 10344.7 6772.4 9923.1 9966.3 10171.2 10452.2 9467.2 9498.9 10114.3 10580.4 10581.3 6915.2 7055.2 7096.0 7257.5 7281.1 7378.8 9490.1 9725.1 9773.3 10179.3 09:20:03 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | [#3] mootools.html Cycles:180 Average:5311.84 Median:6147.48 stddev:2749.94 (44.7%) stddev-sans-first:2741.27 09:20:03 INFO - PROCESS | 13491 | Values: 1319.4 1446.9 1459.3 1592.5 1775.9 7125.2 7297.7 7301.5 7312.2 7331.7 7319.5 7488.3 7498.1 7502.2 7513.0 2176.4 2190.1 2198.3 2198.6 2201.9 2237.7 2259.8 2306.8 2323.4 2324.5 2269.5 2281.6 2292.5 2299.1 2303.1 2242.9 2249.4 2259.5 2260.4 2261.4 2293.9 2302.5 2310.4 2313.9 2316.0 7708.9 7737.8 7741.8 7753.9 7759.8 4505.6 4579.2 4587.4 4588.5 4635.2 3037.9 3052.1 3154.6 3170.9 3178.1 1022.3 1036.5 1039.3 1048.0 1053.2 10330.9 10388.4 10392.1 10414.3 10422.0 4193.6 4259.2 4273.2 4293.8 4299.4 8501.5 8554.0 8566.6 8574.3 8575.4 4550.9 4636.1 4643.6 4651.2 4673.8 3688.8 4023.6 4189.4 4229.3 4232.4 3589.2 3615.0 3651.8 3683.7 3686.1 1165.0 1172.4 1200.3 1215.8 1218.2 922.0 933.6 996.4 1040.7 1066.7 6983.3 7061.5 7104.0 7106.7 7127.9 1044.6 1054.0 1055.3 1056.1 1086.4 5259.7 5337.7 5365.8 5365.9 5380.7 9103.5 9267.4 9481.2 9503.0 9610.8 9333.7 9353.6 9387.2 9426.1 9502.2 7118.5 7261.9 7285.9 7339.7 7353.0 7018.8 7052.8 7064.3 7093.5 7136.5 8289.7 8447.2 8452.2 8634.7 8638.3 8517.2 8711.3 8721.5 8840.7 8892.2 6371.4 6523.2 6547.3 6554.0 6645.7 7056.6 7102.8 7118.5 7123.5 7155.3 6252.4 6348.3 6352.9 6455.6 6488.0 6180.5 6279.3 6284.0 6285.6 6327.1 6621.1 6637.5 6651.0 6686.9 6688.1 6119.4 6124.9 6125.6 6146.6 6148.4 6451.3 6457.1 6503.3 6505.7 6522.2 09:20:03 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | [#4] prototype.html Cycles:180 Average:4655.19 Median:5377.61 stddev:1377.29 (25.6%) stddev-sans-first:1342.01 09:20:03 INFO - PROCESS | 13491 | Values: 311.7 314.4 319.4 319.6 320.4 5257.6 5364.8 5434.8 5456.7 5476.6 5290.3 5362.7 5373.0 5382.2 5383.0 3961.9 4071.6 4133.2 4158.1 4194.1 4151.6 4160.6 4170.0 4181.7 4184.6 4152.7 4154.3 4159.6 4162.4 4173.4 3910.9 4017.2 4085.5 4088.7 4095.5 3567.9 3570.6 3574.2 3574.6 3578.9 5175.6 5182.1 5192.5 5195.6 5197.2 4717.8 4726.1 4728.0 4732.9 4737.5 5640.7 5657.5 5658.0 5664.8 5669.5 3917.5 3924.8 3925.2 3925.4 3926.1 5723.7 5991.6 5994.6 6015.8 6066.3 3939.5 3985.2 3985.2 3987.6 3992.1 4040.9 4054.1 4054.6 4058.7 4061.4 4699.7 4702.8 4704.6 4705.4 4707.4 5703.1 5708.3 5720.7 5721.1 5723.1 1395.4 1398.8 1399.0 1401.7 1403.1 879.9 929.9 936.6 959.5 965.3 4871.4 4897.8 4929.1 4930.7 4939.2 5852.4 5869.3 5872.0 5875.0 5877.1 4919.4 4925.7 4932.7 4934.5 4939.6 3116.3 3148.1 3151.5 3162.0 3165.8 5421.7 5424.7 5433.7 5435.8 5436.3 5785.2 6026.6 6043.7 6049.2 6052.2 5393.7 5411.5 5419.6 5422.2 5424.8 5807.9 5823.7 5827.1 5830.4 5839.1 5763.4 5780.9 5784.0 5787.2 5787.6 5386.2 5391.9 5392.7 5396.1 5397.3 3898.5 4033.0 4034.2 4035.7 4037.1 5787.4 5792.0 5796.3 5800.9 5804.4 5584.5 5588.6 5593.7 5600.3 5607.8 5531.8 5535.0 5542.6 5546.1 5607.9 5299.3 5450.5 5457.6 5458.6 5466.6 5640.3 5643.2 5646.3 5650.9 5652.4 5473.6 5483.7 5515.1 5515.6 5523.9 09:20:03 INFO - PROCESS | 13491 | 09:20:03 INFO - PROCESS | 13491 | [#5] yui.html Cycles:180 Average:12489.14 Median:42306.08 stddev:13813.27 (32.7%) stddev-sans-first:13823.63 09:20:03 INFO - PROCESS | 13491 | Values: 695.8 730.0 742.2 754.2 769.4 12140.2 12396.8 12428.1 12470.7 12479.1 12267.9 12308.4 12312.8 13383.6 13907.2 649.3 798.8 811.3 811.5 811.8 807.1 818.5 824.8 827.0 829.0 853.5 854.2 854.4 855.2 855.3 670.9 679.8 846.0 846.8 847.1 609.1 623.0 624.4 624.8 624.9 12637.2 12735.7 12777.6 12792.3 12826.3 11541.4 11890.7 11898.9 12022.2 12178.4 9699.8 9792.8 9896.4 9970.2 10437.8 3187.2 3234.0 3258.9 3299.6 3311.2 42253.4 42358.8 42989.0 43178.4 43180.8 9639.8 9823.4 9907.0 10018.9 10085.9 16967.9 16969.1 17075.7 17215.7 17222.4 6410.2 6430.7 6542.4 6568.6 6968.4 3865.7 3905.3 3906.8 3915.9 3949.5 2874.9 2893.0 2901.1 2902.8 2909.5 537.6 539.9 547.7 551.2 560.5 501.4 508.6 636.7 640.4 645.2 7931.2 8133.0 8209.6 8304.0 8326.7 469.9 578.4 611.8 615.1 644.5 3713.3 3720.4 3745.7 3783.2 3842.8 48890.5 49677.0 50153.5 50559.0 50726.7 41367.4 42084.0 42361.8 42397.8 45214.8 39737.8 40317.8 40426.6 40758.4 41197.4 7907.0 8059.0 8170.8 8218.9 8225.0 30899.2 31293.0 31981.7 32071.2 32425.2 37436.0 37853.2 39570.0 40491.2 40781.6 10091.5 10245.0 10279.4 10518.5 10542.3 10735.9 10819.8 10980.0 11071.7 11764.8 10915.6 11245.2 11266.0 11552.6 11732.6 10169.6 10292.1 10579.6 10654.8 11084.6 10082.3 10507.6 10537.9 10695.8 10720.1 9445.6 9497.7 9789.5 9797.7 9798.9 9045.7 9369.0 9403.2 9419.2 9577.6 09:20:03 INFO - PROCESS | 13491 | -------- Summary: end -------- 09:20:03 INFO - PROCESS | 13491 | 09:20:04 INFO - TEST-INFO | 13491: exit 0 09:20:04 INFO - TEST-OK | dromaeo_css | took 1116788ms 09:20:04 INFO - TEST-START | kraken 09:20:04 INFO - operating with platform_type : linux_ 09:20:04 INFO - Initialising browser for kraken test... 09:20:04 INFO - TEST-INFO | started process 13672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHiWDhb/profile http://localhost:54971/getInfo.html) 09:20:08 INFO - PROCESS | 13672 | __metrics Screen width/height:1600/1200 09:20:08 INFO - PROCESS | 13672 | colorDepth:24 09:20:08 INFO - PROCESS | 13672 | Browser inner width/height: 1024/697 09:20:08 INFO - PROCESS | 13672 | __metrics 09:20:09 ERROR - PROCESS | 13672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:20:10 INFO - TEST-INFO | 13672: exit 0 09:20:10 INFO - Browser initialized. 09:20:10 INFO - Running cycle 1/1 for kraken test... 09:20:10 INFO - TEST-INFO | started process 13757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHiWDhb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:22 INFO - PROCESS | 13757 | RSS: Main: 153931776 09:20:22 INFO - PROCESS | 13757 | 09:20:24 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54971/tests/kraken/driver.html?testName=audio-beat-detection) 09:20:25 INFO - PROCESS | 13757 | RSS: Main: 196005888 09:20:25 INFO - PROCESS | 13757 | 09:20:28 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54971/tests/kraken/driver.html?testName=audio-dft) 09:20:28 INFO - PROCESS | 13757 | RSS: Main: 185815040 09:20:28 INFO - PROCESS | 13757 | 09:20:31 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54971/tests/kraken/driver.html?testName=audio-fft) 09:20:32 INFO - PROCESS | 13757 | RSS: Main: 170995712 09:20:32 INFO - PROCESS | 13757 | 09:20:34 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54971/tests/kraken/driver.html?testName=audio-oscillator) 09:20:35 INFO - PROCESS | 13757 | RSS: Main: 173223936 09:20:35 INFO - PROCESS | 13757 | 09:20:37 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54971/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:20:38 INFO - PROCESS | 13757 | RSS: Main: 174440448 09:20:38 INFO - PROCESS | 13757 | 09:20:41 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54971/tests/kraken/driver.html?testName=imaging-darkroom) 09:20:41 INFO - PROCESS | 13757 | RSS: Main: 174936064 09:20:41 INFO - PROCESS | 13757 | 09:20:45 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54971/tests/kraken/driver.html?testName=imaging-desaturate) 09:20:45 INFO - PROCESS | 13757 | RSS: Main: 175656960 09:20:45 INFO - PROCESS | 13757 | 09:20:48 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54971/tests/kraken/driver.html?testName=json-parse-financial) 09:20:49 INFO - PROCESS | 13757 | RSS: Main: 175075328 09:20:49 INFO - PROCESS | 13757 | 09:20:50 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54971/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:20:51 INFO - PROCESS | 13757 | RSS: Main: 185974784 09:20:51 INFO - PROCESS | 13757 | 09:20:53 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54971/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:20:53 INFO - PROCESS | 13757 | RSS: Main: 185200640 09:20:53 INFO - PROCESS | 13757 | 09:20:56 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54971/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:20:56 INFO - PROCESS | 13757 | RSS: Main: 195702784 09:20:56 INFO - PROCESS | 13757 | 09:20:59 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:20:59 INFO - PROCESS | 13757 | RSS: Main: 201891840 09:20:59 INFO - PROCESS | 13757 | 09:21:02 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:03 INFO - PROCESS | 13757 | RSS: Main: 201089024 09:21:03 INFO - PROCESS | 13757 | 09:21:04 INFO - PROCESS | 13757 | Cycle 1(1): loaded http://localhost:54971/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54971/tests/kraken/driver.html?testName=ai-astar) 09:21:05 INFO - PROCESS | 13757 | RSS: Main: 262811648 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | __start_tp_report 09:21:05 INFO - PROCESS | 13757 | _x_x_mozilla_page_load 09:21:05 INFO - PROCESS | 13757 | _x_x_mozilla_page_load_details 09:21:05 INFO - PROCESS | 13757 | |i|pagename|runs| 09:21:05 INFO - PROCESS | 13757 | |0;ai-astar;113;114;107;113;113;113;100;112;111;112 09:21:05 INFO - PROCESS | 13757 | |1;audio-beat-detection;163;131;156;181;140;159;154;134;178;140 09:21:05 INFO - PROCESS | 13757 | |2;audio-dft;163;162;162;162;162;162;162;164;163;162 09:21:05 INFO - PROCESS | 13757 | |3;audio-fft;74;77;111;97;75;76;77;116;99;73 09:21:05 INFO - PROCESS | 13757 | |4;audio-oscillator;93;94;139;94;96;95;141;94;95;142 09:21:05 INFO - PROCESS | 13757 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;116;117 09:21:05 INFO - PROCESS | 13757 | |6;imaging-darkroom;147;148;147;146;147;146;146;146;147;146 09:21:05 INFO - PROCESS | 13757 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 09:21:05 INFO - PROCESS | 13757 | |8;json-parse-financial;64;64;66;64;64;64;64;75;62;63 09:21:05 INFO - PROCESS | 13757 | |9;json-stringify-tinderbox;64;64;64;64;64;64;65;64;64;64 09:21:05 INFO - PROCESS | 13757 | |10;stanford-crypto-aes;90;83;85;82;92;83;82;85;84;85 09:21:05 INFO - PROCESS | 13757 | |11;stanford-crypto-ccm;123;120;119;129;121;125;120;131;121;118 09:21:05 INFO - PROCESS | 13757 | |12;stanford-crypto-pbkdf2;144;133;150;144;151;132;143;146;141;148 09:21:05 INFO - PROCESS | 13757 | |13;stanford-crypto-sha256-iterative;69;68;67;69;68;71;70;70;67;69 09:21:05 INFO - PROCESS | 13757 | __end_tp_report 09:21:05 INFO - PROCESS | 13757 | __start_cc_report 09:21:05 INFO - PROCESS | 13757 | _x_x_mozilla_cycle_collect,1130 09:21:05 INFO - PROCESS | 13757 | __end_cc_report 09:21:05 INFO - PROCESS | 13757 | __startTimestamp1459182065008__endTimestamp 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | ------- Summary: start ------- 09:21:05 INFO - PROCESS | 13757 | Number of tests: 14 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#0] ai-astar Cycles:10 Average:110.80 Median:113.00 stddev:4.26 (3.8%) stddev-sans-first:4.45 09:21:05 INFO - PROCESS | 13757 | Values: 113.0 114.0 107.0 113.0 113.0 113.0 100.0 112.0 111.0 112.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:157.50 stddev:17.43 (11.1%) stddev-sans-first:18.15 09:21:05 INFO - PROCESS | 13757 | Values: 163.0 131.0 156.0 181.0 140.0 159.0 154.0 134.0 178.0 140.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 09:21:05 INFO - PROCESS | 13757 | Values: 163.0 162.0 162.0 162.0 162.0 162.0 162.0 164.0 163.0 162.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#3] audio-fft Cycles:10 Average:87.50 Median:76.50 stddev:16.63 (21.7%) stddev-sans-first:16.90 09:21:05 INFO - PROCESS | 13757 | Values: 74.0 77.0 111.0 97.0 75.0 76.0 77.0 116.0 99.0 73.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:22.36 (23.8%) stddev-sans-first:23.02 09:21:05 INFO - PROCESS | 13757 | Values: 93.0 94.0 139.0 94.0 96.0 95.0 141.0 94.0 95.0 142.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:21:05 INFO - PROCESS | 13757 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:21:05 INFO - PROCESS | 13757 | Values: 147.0 148.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:21:05 INFO - PROCESS | 13757 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:64.00 stddev:3.65 (5.7%) stddev-sans-first:3.86 09:21:05 INFO - PROCESS | 13757 | Values: 64.0 64.0 66.0 64.0 64.0 64.0 64.0 75.0 62.0 63.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 09:21:05 INFO - PROCESS | 13757 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:3.35 (3.9%) stddev-sans-first:3.05 09:21:05 INFO - PROCESS | 13757 | Values: 90.0 83.0 85.0 82.0 92.0 83.0 82.0 85.0 84.0 85.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.00 stddev:4.35 (3.6%) stddev-sans-first:4.61 09:21:05 INFO - PROCESS | 13757 | Values: 123.0 120.0 119.0 129.0 121.0 125.0 120.0 131.0 121.0 118.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:145.00 stddev:6.44 (4.4%) stddev-sans-first:6.83 09:21:05 INFO - PROCESS | 13757 | Values: 144.0 133.0 150.0 144.0 151.0 132.0 143.0 146.0 141.0 148.0 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - PROCESS | 13757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.39 09:21:05 INFO - PROCESS | 13757 | Values: 69.0 68.0 67.0 69.0 68.0 71.0 70.0 70.0 67.0 69.0 09:21:05 INFO - PROCESS | 13757 | -------- Summary: end -------- 09:21:05 INFO - PROCESS | 13757 | 09:21:05 INFO - TEST-INFO | 13757: exit 0 09:21:06 INFO - TEST-OK | kraken | took 61520ms 09:21:06 INFO - SUITE-END | took 1178s 09:21:06 INFO - Completed test suite (00:19:38) 09:21:06 INFO - javascript benchmark 09:21:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2579.9226023219303, 2655.3361659585103, 2657.4020845309797, 2667.0665267156496, 2681.4368982513665, 4599.149157405882, 4644.674872758904, 4675.0, 4692.038132182907, 4706.69406488578, 4663.790129444174, 4687.90624187516, 4693.413323334583, 4759.333693282934, 4759.833405830796, 4272.337787642905, 4305.268104422255, 4308.633766129883, 4319.179355922381, 4428.579284967939, 4380.912381752363, 4381.956180438203, 4386.188555117314, 4386.605205531501, 4399.03221291317, 4254.361845723135, 4326.221280169569, 4328.61042506176, 4331.566843315674, 4367.672424568138, 4275.0594869128745, 4292.871213863558, 4305.440292761952, 4344.23975804233, 4374.825006999717, 4260.062786187033, 4265.104328091104, 4267.274563324242, 4293.656507479425, 4311.698181127323, 4467.15124126415, 4507.932381014288, 4567.451905771295, 4570.314452832102, 4625.398698169251, 5058.266551350033, 5061.114304996611, 5064.290999260106, 5087.109755792759, 5109.540141387293, 5100.28595996557, 5111.897762044776, 5124.846254612367, 5125.487451254882, 5183.429822719498, 4529.977350113229, 4685.67200295976, 4741.122892264942, 4750.4299484061785, 4770.713757174512, 5136.8715782105, 5143.27994080829, 5171.3535808024, 5172.767225474862, 5194.246834209019, 4929.876753081202, 4932.975335123373, 4935.432425271139, 4936.506349365035, 4986.15235409974, 4932.580730637936, 4983.302337672729, 4985.252212168204, 4989.600831933437, 5002.274670172877, 5059.06407314648, 5059.19052951526, 5059.72171530562, 5060.49395060491, 5104.1578139606545, 5021.5229553192385, 5041.546260836542, 5043.3191519145175, 5048.7728052237735, 5098.337216161949, 4193.853215137517, 4272.636825869836, 4276.273033584298, 4302.032042790347, 4369.235383807821, 3721.813909304524, 3746.587875333711, 3750.1749615084636, 3781.3382658034734, 3807.3908174691915, 4341.327094300388, 4363.563643635611, 4364.258076127066, 4365.0, 4405.515393306734, 4965.3048573199785, 5044.1929291313945, 5112.948870511322, 5122.334096567422, 5149.356330458692, 4355.455568053993, 4374.737515749001, 4394.560543945644, 4418.182636212311, 4422.933655995163, 4627.190241707755, 4629.8148074077335, 4630.282306242538, 4663.930041049387, 4684.8360307389075, 4598.0, 4706.987997580537, 4724.811007559659, 4762.333273341735, 4772.498887616889, 5107.080725469303, 5116.923246151385, 5119.283300337881, 5127.974360128175, 5163.8192663256605, 4728.3380326753595, 4748.691335063209, 4756.738379389167, 4757.333973243818, 4798.760061996816, 4828.5412885775795, 4849.612031037438, 4886.486918873467, 5007.098722230034, 5067.493250674903, 5044.924326135184, 5060.898782024413, 5075.7969681212335, 5076.619253555924, 5093.719845408538, 4872.537108974641, 4882.536159064884, 4887.511248875084, 4888.560029597354, 4893.192623217129, 4821.156297647968, 4898.559129678346, 4946.505349465025, 4983.202687570117, 4999.625028122832, 4799.3760811094335, 4827.179379505422, 4831.758412079312, 4832.95167048325, 4841.806327746992, 4906.509349065065, 4909.95090049095, 4910.140725372974, 4920.065187614485, 4966.031623833463, 4694.812207511662, 4749.168895443353, 4835.178019736582, 4840.757962101951, 4843.733594652187], "unit": "score", "name": "dojo.html", "value": 4629.495238428151}, {"lowerIsBetter": false, "replicates": [535.799075346745, 538.3754844380518, 562.0501352713914, 563.8646724786053, 575.9769609215632, 27640.723592764065, 35277.0, 36082.63917360829, 36180.45729314056, 36212.81893590535, 38396.232075358545, 38695.613043869555, 38771.22457550847, 38811.41782873259, 38873.0, 7753.379729621617, 7936.563489008102, 7940.880886786703, 7948.7217947371855, 7960.522368657899, 7741.612919354038, 7827.099883513412, 7835.412344074189, 7838.412119091063, 8064.233897779702, 8012.158723334053, 8081.5555144467035, 8085.191480851927, 8090.757277281661, 8093.514389136671, 7996.600169991477, 8069.878951815727, 8070.798230044237, 8075.636596353149, 8081.353491720707, 8009.759707208793, 8121.75634730959, 8128.065272493621, 8130.959345203295, 8136.837263254761, 39507.0, 39608.20783584341, 39910.60089399098, 39911.0, 39969.80015099906, 2936.4420760055523, 3092.273315770792, 3344.8494817733263, 3830.8467661293516, 3889.436031775405, 29679.406411871856, 29917.25206869824, 30006.699933000607, 30050.84974575135, 30300.696993030007, 3446.4485682290715, 3494.8427320770625, 3538.840752166133, 3615.2950174715943, 3643.981780091109, 234256.0, 236014.0, 236106.0, 236571.0, 237854.0, 42939.0, 43902.12195756067, 50224.48428609962, 50880.49119508832, 51363.743181283855, 44617.330740038924, 44883.55116448794, 44887.0, 44952.3257151143, 45024.3246351305, 13713.657158571115, 13860.099093559089, 13867.0, 13871.306434678225, 13875.861241387456, 10200.234982376203, 10200.642977495752, 10201.336913100624, 10218.080372766486, 10223.182145428347, 14902.329395177243, 14966.17686027279, 14975.1014939104, 15021.098734075991, 15141.318640660977, 5678.261825962599, 5899.911501327483, 5913.970430147821, 5922.703864806828, 5924.259467566554, 883.7702197428715, 904.3217586809892, 907.945523268606, 932.8414169591185, 993.7366597851575, 27018.5947210792, 27697.584536231974, 27971.44057118846, 28216.43567128646, 28216.8589157057, 1016.5019140621042, 1039.3400190878695, 1044.2690116918188, 1102.6416414665266, 1122.6014764758393, 13941.651458713613, 14483.637909052359, 14631.990784874577, 14722.0, 14731.116133032052, 272127.0, 275063.0, 275613.0, 276026.0, 276311.0, 48113.0, 48515.75742121267, 48742.75628621834, 48789.5121048785, 48871.0, 1079.611339917629, 1178.976420471603, 1244.6577191272472, 1254.5170109507906, 1271.205496564647, 24089.382588478624, 27615.44769104647, 27833.44333113367, 28087.859560702884, 28139.43721125607, 38788.6121138785, 39157.8042109799, 39555.2088958225, 39654.603453965094, 39657.80171099126, 170238.0, 171503.0, 171673.0, 171715.0, 171721.1413942972, 27065.323366915985, 31016.0, 31343.0, 31343.529847051857, 32430.189245269055, 33665.0, 35687.464688029184, 39620.405693914036, 39866.0, 39966.400503991885, 32866.1783455406, 33331.50002750009, 33985.15037124092, 34295.0, 34414.655853441145, 33493.0, 34008.48987265144, 34208.82895585506, 34253.828730856185, 34509.827450862584, 33604.83197583997, 34342.65657343494, 34456.31087378289, 34703.4794478078, 34773.47839782355, 28533.0, 28715.13854584366, 30545.847270763505, 30584.84707576448, 30901.227469312547, 24364.0, 24382.87808560946, 24525.141620043927, 24599.38501537476, 24735.87632061828], "unit": "score", "name": "ext.html", "value": 16617.228060001926}, {"lowerIsBetter": false, "replicates": [352.94176460883966, 354.2242488949201, 355.34616305996974, 357.3710269924931, 366.7799320407754, 15439.45961891334, 15750.0, 16266.349346026145, 16707.331706731715, 16807.66384672306, 14265.92867035666, 14379.281035948214, 16396.26216820243, 16398.26207820648, 16579.91710041451, 4880.389951256093, 4914.680545764531, 5051.696898186102, 5077.898442031157, 5130.333056702642, 4975.303457515951, 5057.342545469102, 5082.339295891547, 5098.439171691111, 5098.43917169113, 5041.596672266228, 5044.545990860822, 5057.367829021372, 5061.44324124346, 5064.417591976933, 5479.972600136994, 5679.091345384719, 5699.715014249271, 5704.258446401941, 5712.971435142818, 5058.266551350033, 5058.848234552933, 5077.771500282459, 5079.339685840817, 5082.517160869711, 11519.078473722082, 11547.595834145848, 11547.884521154765, 11557.653270401901, 11799.469023893946, 1888.726134710473, 1935.525796179931, 2049.3954283486405, 2121.2999710095787, 2121.469632591852, 8732.650693972233, 8796.69211577598, 8872.73381798547, 8898.555072246427, 10879.0, 1731.6017316017387, 1759.8064212936567, 1767.5757818123686, 1780.6794776940146, 1837.5222442165, 40064.59935400667, 53858.19212711813, 54435.99999999961, 57099.0, 61075.69462152705, 8876.068012858686, 9344.906550934404, 9352.438853668802, 9439.952800235955, 9677.322587418954, 11947.701307467383, 12255.877441225473, 12303.507859685691, 12348.012159027436, 12471.812922806164, 6785.626790526569, 6859.07402500666, 6909.378155965987, 7021.0, 7167.498275120692, 6358.300586935434, 6448.387403196689, 6716.126903502513, 6910.136232970879, 6994.68523916425, 4131.731437456556, 4291.034517233597, 4313.245182093121, 4322.351647252937, 4362.105768317488, 1723.1814887928133, 1730.316524972654, 1742.451127894709, 1762.3038899634828, 1783.3134243316417, 869.3306154261184, 882.5102068352127, 905.7554460295684, 919.632147141149, 928.331601247101, 15850.920745396199, 16101.67796644084, 16121.919390402973, 16408.0, 16774.49676509707, 852.5140669818144, 874.5933141089424, 890.9777255568533, 899.9965038981488, 905.2622112977901, 7582.393408527305, 9152.130547597968, 9153.908460915438, 9690.235891907041, 9725.61097556104, 382415.0, 382679.0, 411734.0, 415851.0, 421077.0, 45357.773211134394, 45484.09031819411, 66386.00420993689, 67354.32645673578, 75306.0, 956.9043095690375, 969.069693094623, 972.4262685015875, 987.8863930648067, 992.4591097851544, 15006.849931500981, 15171.468998584996, 15322.923385383448, 15409.075455472708, 15653.21733913277, 23439.29682109471, 29434.0, 34104.0, 34201.97394078182, 34965.300693986486, 46160.30759538677, 48544.0, 48599.75700121477, 48649.513504865914, 49464.0, 7193.568385896863, 7323.707051717872, 7497.137829149718, 7574.924250757422, 7616.619169041415, 9357.298202634693, 11723.531058757895, 11752.529898804294, 11767.0, 11797.52809887595, 10074.798504030025, 10161.898381016095, 10202.38785672862, 10226.41490568963, 10344.741381465223, 6772.390484856386, 9923.1069203772, 9966.252531060345, 10171.23715721309, 10452.216083793897, 9467.242620590474, 9498.905010949802, 10114.342567733074, 10580.41807700584, 10581.259311848406, 6915.170179578483, 7055.153381594037, 7096.0, 7257.491975561871, 7281.1262648482525, 7378.815529611803, 9490.098440648128, 9725.124738773544, 9773.267004974514, 10179.338343007681], "unit": "score", "name": "jquery.html", "value": 7729.499099833243}, {"lowerIsBetter": false, "replicates": [1319.4260496683949, 1446.8625480579342, 1459.2849503743162, 1592.4585640882099, 1775.937842175524, 7125.180604230515, 7297.744578939738, 7301.488895777285, 7312.159101703306, 7331.670074846638, 7319.451041171907, 7488.288612581796, 7498.100227972651, 7502.249775022495, 7513.0233069701, 2176.379731776444, 2190.0692205812547, 2198.318521258407, 2198.5712786006734, 2201.856879302848, 2237.7090978172896, 2259.7740225977436, 2306.7923886850263, 2323.3959170615594, 2324.500232450023, 2269.534745377202, 2281.577908087001, 2292.518571100071, 2299.1033496936125, 2303.1248125712204, 2242.9102835886547, 2249.3814201094665, 2259.4916143867663, 2260.378395941113, 2261.3555136786017, 2293.896774645145, 2302.5279817637343, 2310.353101131686, 2313.8958746856433, 2315.9652605210767, 7708.922910770877, 7737.806554836118, 7741.806454838674, 7753.883691744629, 7759.7672069838, 4505.639548836085, 4579.152856721517, 4587.357769912215, 4588.49526552079, 4635.2120139576355, 3037.8936737214312, 3052.145399288203, 3154.6056742907135, 3170.9048728538182, 3178.141901686555, 1022.258862324816, 1036.4765793274348, 1039.3348257115451, 1047.9790404191874, 1053.1890444357878, 10330.89669103307, 10388.376697398106, 10392.06471417576, 10414.323069000491, 10422.0, 4193.559676233952, 4259.190753756776, 4273.209456250604, 4293.849715259951, 4299.398084268205, 8501.48991060526, 8553.95723021381, 8566.61450234741, 8574.314054875595, 8575.399722019523, 4550.931736023962, 4636.095961287584, 4643.582077613031, 4651.186042442559, 4673.836415725434, 3688.7602305850032, 4023.597640235953, 4189.4344263524035, 4229.281022226229, 4232.449781528443, 3589.1565482111682, 3615.0, 3651.7626354286886, 3683.723720720957, 3686.060054686038, 1164.9941750291193, 1172.4255114993591, 1200.2678366196612, 1215.769003889258, 1218.2446882932638, 921.999630401009, 933.5518950903469, 996.3573495095623, 1040.7450174707094, 1066.6799960011965, 6983.266756990544, 7061.505694601328, 7104.0, 7106.7157313706875, 7127.89308160378, 1044.566504900473, 1053.9894601054045, 1055.3245922609535, 1056.1286938275953, 1086.3807629651023, 5259.658122222043, 5337.6797392156595, 5365.8390248291835, 5365.865853353697, 5380.704061276589, 9103.49930753815, 9267.44395336282, 9481.24150067993, 9503.0, 9610.807783844424, 9333.719988400358, 9353.625854965861, 9387.249020078378, 9426.104520070583, 9502.192313653279, 7118.466115041392, 7261.8547629047125, 7285.927140728631, 7339.669714862844, 7353.0, 7018.75434359795, 7052.753153639598, 7064.32888875556, 7093.467989900882, 7136.4647651427385, 8289.668413263402, 8447.239748422671, 8452.239298462922, 8634.654613815377, 8638.308935285288, 8517.23344898962, 8711.303095752199, 8721.520316382659, 8840.690575829814, 8892.244159246537, 6371.426571608392, 6523.18460192476, 6547.312532184243, 6553.967230163818, 6645.734170633121, 7056.576605403692, 7102.751403700846, 7118.537295075804, 7123.465740069619, 7155.3202445767565, 6252.406021427957, 6348.301686814354, 6352.872942541031, 6455.580387274812, 6488.0, 6180.536459765445, 6279.277883043508, 6284.0, 6285.622862628257, 6327.11420401135, 6621.073049773132, 6637.53537252407, 6650.9667451662435, 6686.899696504459, 6688.130543029375, 6119.418655227746, 6124.928137575996, 6125.601835880653, 6146.600470969552, 6148.354422785543, 6451.258105317948, 6457.0637257596445, 6503.349665033459, 6505.707243173973, 6522.15212022434], "unit": "score", "name": "mootools.html", "value": 4372.493220353205}, {"lowerIsBetter": false, "replicates": [311.7007672634271, 314.3791012749819, 319.3724331688233, 319.60847961247475, 320.4184405304374, 5257.553107985821, 5364.758585863636, 5434.809781657638, 5456.699881506515, 5476.616636835423, 5290.259363689077, 5362.678239305635, 5373.0, 5382.2195781611645, 5382.9730851345785, 3961.861334853281, 4071.5928407159345, 4133.2353514599745, 4158.147579746144, 4194.119234960662, 4151.626353628173, 4160.625543701066, 4169.9791501042455, 4181.665466762652, 4184.644305234059, 4152.709310348277, 4154.31453810121, 4159.604837540429, 4162.354835000579, 4173.4157217989505, 3910.863119790808, 4017.1965606878593, 4085.468889044435, 4088.693347998912, 4095.4675892133832, 3567.928641427183, 3570.6429357064344, 3574.249407624402, 3574.5531808523933, 3578.8926332209817, 5175.637705360627, 5182.067227898977, 5192.454792246797, 5195.610329225323, 5197.246399272122, 4717.834875779331, 4726.0784147091335, 4727.95272047282, 4732.881677958078, 4737.50256223095, 5640.717964101819, 5657.462541058593, 5658.038133517271, 5664.773409063632, 5669.489745922887, 3917.5298964124486, 3924.7841368724708, 3925.21495700861, 3925.391564307537, 3926.1362500249897, 5723.685197314146, 5991.580589358747, 5994.580379373446, 6015.849603759941, 6066.302375226817, 3939.468171796828, 3985.1830374773103, 3985.20295940813, 3987.601239876047, 3992.121733218687, 4040.8585699500377, 4054.1486287879284, 4054.5742697016976, 4058.6955978301744, 4061.3501839705505, 4699.660596729984, 4702.811887524529, 4704.623630109583, 4705.435347758291, 4707.435107787088, 5703.144528320702, 5708.31500219968, 5720.713964301768, 5721.084626459747, 5723.112917497794, 1395.386030146732, 1398.7692030815006, 1398.9580312590638, 1401.7336706026026, 1403.0809819568199, 879.8900137482815, 929.9070092990647, 936.6019441737235, 959.5490119643756, 965.3339195954769, 4871.439784424837, 4897.8285759998225, 4929.137400954819, 4930.728809915489, 4939.234418665113, 5852.385499522574, 5869.325027621878, 5872.0, 5875.0, 5877.089051197071, 4919.409670839522, 4925.729084900293, 4932.679375840559, 4934.481879402683, 4939.5554400104165, 3116.2676770958806, 3148.0870547541413, 3151.527270909382, 3161.9525707114412, 3165.778395512292, 5421.728913554307, 5424.728763561806, 5433.728313584305, 5435.755391007414, 5436.3476382834315, 5785.247917770663, 6026.608270462493, 6043.7280322385595, 6049.213602231682, 6052.243469566304, 5393.703346315911, 5411.540019098342, 5419.566434685137, 5422.240886275925, 5424.755885985219, 5807.94192058074, 5823.70881455934, 5827.096799996008, 5830.358660547252, 5839.065749480063, 5763.394843541368, 5780.884382312414, 5784.045632470596, 5787.189793429007, 5787.594868359343, 5386.165144402624, 5391.919121213106, 5392.676439413491, 5396.1366181410785, 5397.325334333208, 3898.4737060497605, 4032.979835100923, 4034.213328401051, 4035.6569691576547, 4037.0714735610386, 5787.421257874179, 5792.0, 5796.333421656564, 5800.883982320245, 5804.419558044162, 5584.46947539983, 5588.552915766811, 5593.664380137205, 5600.299962504687, 5607.831765047055, 5531.751071201725, 5534.972325138348, 5542.584306177134, 5546.057170280981, 5607.859803504945, 5299.258103865539, 5450.536704380013, 5457.61796674229, 5458.61789674719, 5466.562674986071, 5640.323161220515, 5643.238162847963, 5646.265985421869, 5650.886982260414, 5652.406497317723, 5473.589480788877, 5483.698396588226, 5515.062439385234, 5515.558755299486, 5523.922835047128], "unit": "score", "name": "prototype.html", "value": 4212.026678202528}, {"lowerIsBetter": false, "replicates": [695.7564852301695, 730.0254160695471, 742.1835980421537, 754.2419868032626, 769.4190885881159, 12140.210886292385, 12396.81404778928, 12428.13003089784, 12470.688232794184, 12479.064070194727, 12267.877321226784, 12308.384580770948, 12312.815307770368, 13383.59849204523, 13907.165570065803, 649.2987573420718, 798.7963069417304, 811.2820154163578, 811.4928169893816, 811.8498077855586, 807.1202389395557, 818.5129847740615, 824.7525742277322, 827.0447632983883, 829.0465964141256, 853.4665833853842, 854.2311919272643, 854.3891117850735, 855.1875718067829, 855.2901092093548, 670.8993650952348, 679.7722762874444, 845.9873101903477, 846.7502086884354, 847.1316900177337, 609.0590038390696, 622.953278504114, 624.4380057947837, 624.7750809708501, 624.8594066335083, 12637.178583392142, 12735.681607959783, 12777.552785652457, 12792.296423696693, 12826.294553799537, 11541.422928853524, 11890.702732431759, 11898.881011189951, 12022.218555793845, 12178.391080445943, 9699.757506062335, 9792.755181120458, 9896.406215627085, 9970.20238380935, 10437.79124417515, 3187.235063584746, 3234.045956442855, 3258.8696452141885, 3299.6205436374644, 3311.1887587540964, 42253.36619950703, 42358.78820605908, 42989.0, 43178.35232471515, 43180.78409607963, 9639.807203855884, 9823.36148150368, 9906.950465247628, 10018.883812238058, 10085.949570252102, 16967.915160424367, 16969.0667013313, 17075.65848683044, 17215.65568688619, 17222.397216097375, 6410.23077230726, 6430.7106180222, 6542.378474044958, 6568.573042752206, 6968.3728464438445, 3865.6714179295077, 3905.3165696003653, 3906.8437262509183, 3915.941260881089, 3949.486566746362, 2874.9137525874257, 2893.045295052628, 2901.0716570697596, 2902.782291328159, 2909.5199292116986, 537.6317222702461, 539.91631297149, 547.6932917566176, 551.2392897801009, 560.4983539731917, 501.4208589079619, 508.57279884896127, 636.7484843486797, 640.401224854753, 645.2289514030688, 7931.246531579491, 8132.959335203286, 8209.58952052395, 8303.95848020756, 8326.66693332272, 469.926218590519, 578.3551340255585, 611.8286879673699, 615.0804547201961, 644.4554351573007, 3713.313037088147, 3720.4233343831747, 3745.7190710696805, 3783.1677031053123, 3842.7886466244067, 48890.511094889305, 49677.0, 50153.49846501561, 50559.0, 50726.74636626867, 41367.379489307685, 42084.0, 42361.788191059466, 42397.788011060366, 45214.773926130816, 39737.80131099384, 40317.79841100834, 40426.59573404287, 40758.388624170664, 41197.38203926943, 7906.960465197637, 8058.959705201437, 8170.754877353689, 8218.917810822055, 8224.971878515185, 30899.227519312197, 31293.0, 31981.6801831988, 32071.198220043752, 32425.189370265933, 37436.0, 37853.242935140595, 39570.0, 40491.19017619572, 40781.59218407897, 10091.495425228855, 10245.026722461354, 10279.383237005804, 10518.526666299882, 10542.314749541256, 10735.892641073802, 10819.783604328028, 10980.0, 11071.723206919569, 11764.823527647264, 10915.563377464812, 11245.156613254203, 11266.042386397248, 11552.59565915189, 11732.648020559396, 10169.644062457779, 10292.125169360688, 10579.576816927236, 10654.786904262026, 11084.61203857861, 10082.29423940317, 10507.579696812347, 10537.89462105369, 10695.786084278427, 10720.142388608736, 9445.622175112918, 9497.667581634609, 9789.510524473606, 9797.671909263012, 9798.85301720489, 9045.728628141167, 9368.95315523418, 9403.247740180632, 9419.199368053793, 9577.569009394734], "unit": "score", "name": "yui.html", "value": 5894.522785536335}], "name": "dromaeo_css", "value": 6333.72033766602}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 107.0, 113.0, 113.0, 113.0, 100.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [163.0, 131.0, 156.0, 181.0, 140.0, 159.0, 154.0, 134.0, 178.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 153.6}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 164.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 111.0, 97.0, 75.0, 76.0, 77.0, 116.0, 99.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 139.0, 94.0, 96.0, 95.0, 141.0, 94.0, 95.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 66.0, 64.0, 64.0, 64.0, 64.0, 75.0, 62.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [90.0, 83.0, 85.0, 82.0, 92.0, 83.0, 82.0, 85.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [123.0, 120.0, 119.0, 129.0, 121.0, 125.0, 120.0, 131.0, 121.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [144.0, 133.0, 150.0, 144.0, 151.0, 132.0, 143.0, 146.0, 141.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 69.0, 68.0, 71.0, 70.0, 70.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1529.8999999999999}]} 09:21:06 INFO - Return code: 0 09:21:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:21:06 ERROR - # TBPL SUCCESS # 09:21:06 INFO - Running post-action listener: _resource_record_post_action 09:21:06 INFO - Running post-run listener: _resource_record_post_run 09:21:07 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 382021632; Read time: 16; Write time: 259840 09:21:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94343168; Read time: 0; Write time: 48728 09:21:07 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287678464; Read time: 16; Write time: 211112 09:21:07 INFO - Running post-run listener: _upload_blobber_files 09:21:07 INFO - Blob upload gear active. 09:21:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:07 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 09:21:07 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'] 09:21:07 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 09:21:07 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:21:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:08 INFO - (blobuploader) - INFO - Done attempting. 09:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:09 INFO - (blobuploader) - INFO - Done attempting. 09:21:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:09 INFO - Return code: 0 09:21:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c527b9ab257cae548167a3879e35b286dc02e1e77f93374000e480f45b1f38dd093eb45195342c1847a4818e05088ffe26248204fd016691379ed26e3c437811", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2da79d13aabfe353ba023b031cafeaa03103e32f938e4096b6a963d8a66e5c30802f91e64178eb36177b54c120e0e45badef0380abe3dbd13b0b16d367f413e"} 09:21:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:09 INFO - Contents: 09:21:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c527b9ab257cae548167a3879e35b286dc02e1e77f93374000e480f45b1f38dd093eb45195342c1847a4818e05088ffe26248204fd016691379ed26e3c437811", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2da79d13aabfe353ba023b031cafeaa03103e32f938e4096b6a963d8a66e5c30802f91e64178eb36177b54c120e0e45badef0380abe3dbd13b0b16d367f413e"} 09:21:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:09 INFO - Copying logs to upload dir... 09:21:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.708259 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-03-28 09:21:09.215811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 09:21:09.219028) ========= 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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 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/c527b9ab257cae548167a3879e35b286dc02e1e77f93374000e480f45b1f38dd093eb45195342c1847a4818e05088ffe26248204fd016691379ed26e3c437811", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2da79d13aabfe353ba023b031cafeaa03103e32f938e4096b6a963d8a66e5c30802f91e64178eb36177b54c120e0e45badef0380abe3dbd13b0b16d367f413e"} build_url:https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/cROxbER1RS-lm5GLshIVgA/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/c527b9ab257cae548167a3879e35b286dc02e1e77f93374000e480f45b1f38dd093eb45195342c1847a4818e05088ffe26248204fd016691379ed26e3c437811", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e2da79d13aabfe353ba023b031cafeaa03103e32f938e4096b6a963d8a66e5c30802f91e64178eb36177b54c120e0e45badef0380abe3dbd13b0b16d367f413e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 09:21:09.247484) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:21:09.248174) ========= 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=523ca41ca1e0623de333ad52000001bf-1459180149.347794-1923168660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 09:21:09.333395) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 09:21:09.334117) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 09:21:09.334797) ========= ========= Total master_lag: 0.45 =========