builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1457980654.15 results: success (0) buildid: 20160314103926 builduid: 21f4522f19504b66885a672f999c81c8 revision: 2602e9da8592ce52e68a22203881ab238506cc94 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.147144) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.147619) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.147916) ========= 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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006254 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.170204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.170479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.183315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.183620) ========= 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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.232683) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.232989) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.233384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.233659) ========= 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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 11:37:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-03-14 11:37:34 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.399340 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.645229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.645538) ========= 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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019775 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:34.695094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 11:37:34.695507) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2602e9da8592ce52e68a22203881ab238506cc94 --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 2602e9da8592ce52e68a22203881ab238506cc94 --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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 11:37:35,104 truncating revision to first 12 chars 2016-03-14 11:37:35,104 Setting DEBUG logging. 2016-03-14 11:37:35,105 attempt 1/10 2016-03-14 11:37:35,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2602e9da8592?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 11:37:36,169 unpacking tar archive at: fx-team-2602e9da8592/testing/mozharness/ program finished with exit code 0 elapsedTime=1.667911 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 11:37:36.379532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:36.379917) ========= echo 2602e9da8592ce52e68a22203881ab238506cc94 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2602e9da8592ce52e68a22203881ab238506cc94'] 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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2602e9da8592ce52e68a22203881ab238506cc94 program finished with exit code 0 elapsedTime=0.004641 script_repo_revision: '2602e9da8592ce52e68a22203881ab238506cc94' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:36.430669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:36.434019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 11:37:36.446771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-14 11:37:36.447154) ========= /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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:37:36 INFO - MultiFileLogger online at 20160314 11:37:36 in /builds/slave/test 11:37:36 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 11:37:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:37:36 INFO - {'append_to_log': False, 11:37:36 INFO - 'base_work_dir': '/builds/slave/test', 11:37:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:37:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:37:36 INFO - 'branch': 'Fx-Team-Non-PGO', 11:37:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:37:36 INFO - 'config_files': ('talos/linux_config.py',), 11:37:36 INFO - 'default_actions': ('clobber', 11:37:36 INFO - 'read-buildbot-config', 11:37:36 INFO - 'download-and-extract', 11:37:36 INFO - 'populate-webroot', 11:37:36 INFO - 'create-virtualenv', 11:37:36 INFO - 'install', 11:37:36 INFO - 'run-tests'), 11:37:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:37:36 INFO - 'download_minidump_stackwalk': True, 11:37:36 INFO - 'download_symbols': 'ondemand', 11:37:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:37:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:37:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:37:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:37:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:37:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:37:36 INFO - 'installer_path': 'installer.exe', 11:37:36 INFO - 'log_level': 'info', 11:37:36 INFO - 'log_name': 'talos', 11:37:36 INFO - 'log_to_console': True, 11:37:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:37:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:37:36 INFO - 'opt_config_files': (), 11:37:36 INFO - 'pip_index': False, 11:37:36 INFO - 'sps_profile': False, 11:37:36 INFO - 'sps_profile_interval': 0, 11:37:36 INFO - 'suite': 'dromaeojs', 11:37:36 INFO - 'system_bits': '32', 11:37:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:37:36 INFO - 'title': 'talos-linux64-ix-043', 11:37:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:37:36 INFO - 'use_talos_json': True, 11:37:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:37:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:37:36 INFO - 'work_dir': 'build'} 11:37:36 INFO - ##### 11:37:36 INFO - ##### Running clobber step. 11:37:36 INFO - ##### 11:37:36 INFO - Running pre-action listener: _resource_record_pre_action 11:37:36 INFO - Running main action method: clobber 11:37:36 INFO - rmtree: /builds/slave/test/build 11:37:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:37:37 INFO - Running post-action listener: _resource_record_post_action 11:37:37 INFO - ##### 11:37:37 INFO - ##### Running read-buildbot-config step. 11:37:37 INFO - ##### 11:37:37 INFO - Running pre-action listener: _resource_record_pre_action 11:37:37 INFO - Running main action method: read_buildbot_config 11:37:37 INFO - Using buildbot properties: 11:37:37 INFO - { 11:37:37 INFO - "project": "", 11:37:37 INFO - "product": "firefox", 11:37:37 INFO - "script_repo_revision": "production", 11:37:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:37:37 INFO - "repository": "", 11:37:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:37:37 INFO - "buildid": "20160314103926", 11:37:37 INFO - "pgo_build": "False", 11:37:37 INFO - "basedir": "/builds/slave/test", 11:37:37 INFO - "buildnumber": 1443, 11:37:37 INFO - "slavename": "talos-linux64-ix-043", 11:37:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:37:37 INFO - "platform": "ubuntu64_hw", 11:37:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:37:37 INFO - "branch": "fx-team", 11:37:37 INFO - "repo_path": "integration/fx-team", 11:37:37 INFO - "revision": "2602e9da8592ce52e68a22203881ab238506cc94", 11:37:37 INFO - "stage_platform": "linux64", 11:37:37 INFO - "builduid": "21f4522f19504b66885a672f999c81c8", 11:37:37 INFO - "slavebuilddir": "test" 11:37:37 INFO - } 11:37:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:37:37 INFO - Running post-action listener: _resource_record_post_action 11:37:37 INFO - ##### 11:37:37 INFO - ##### Running download-and-extract step. 11:37:37 INFO - ##### 11:37:37 INFO - Running pre-action listener: _resource_record_pre_action 11:37:37 INFO - Running main action method: download_and_extract 11:37:37 INFO - mkdir: /builds/slave/test/build/tests 11:37: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')]} 11:37:37 INFO - https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:37:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:37:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:37:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:38 INFO - Downloaded 1361 bytes. 11:37:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:37:38 INFO - Using the following test package requirements: 11:37:38 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:37:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:37:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:38 INFO - u'jsshell-linux-x86_64.zip'], 11:37:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:37:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:37:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:37:38 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:37:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:37:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:37:38 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:37:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:38 INFO - https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:37:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:37:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:37:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:39 INFO - Downloaded 21990794 bytes. 11:37:39 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'] 11:37:39 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 11:37:40 INFO - Return code: 0 11:37:40 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 11:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:40 INFO - https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:42 INFO - Downloaded 21990794 bytes. 11:37:42 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'] 11:37:42 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 11:37:43 INFO - Return code: 0 11:37:43 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')]} 11:37:43 INFO - https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:37:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:37:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:44 INFO - Downloaded 10845263 bytes. 11:37:44 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'] 11:37:44 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 11:37:44 INFO - Return code: 0 11:37: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')]} 11:37:44 INFO - https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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 11:37:46 INFO - Downloaded 54132604 bytes. 11:37:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:37:46 INFO - mkdir: /builds/slave/test/properties 11:37:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:46 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:46 INFO - Contents: 11:37:46 INFO - build_url:https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:37:47 INFO - Running post-action listener: _resource_record_post_action 11:37:47 INFO - Running post-action listener: set_extra_try_arguments 11:37:47 INFO - ##### 11:37:47 INFO - ##### Running populate-webroot step. 11:37:47 INFO - ##### 11:37:47 INFO - Running pre-action listener: _resource_record_pre_action 11:37:47 INFO - Running main action method: populate_webroot 11:37:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:47 INFO - '--tppagecycles', 11:37:47 INFO - '7'], 11:37:47 INFO - 'tests': ['tsvgm']}}, 11:37:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:37:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:37:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:47 INFO - 'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:47 INFO - 'tests': ['damp', 'tps']}, 11:37:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:47 INFO - 'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['damp', 'tps']}, 11:37:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:37:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:47 INFO - 'other': {'tests': ['a11yr', 11:37:47 INFO - 'ts_paint', 11:37:47 INFO - 'tpaint', 11:37:47 INFO - 'sessionrestore', 11:37:47 INFO - 'sessionrestore_no_auto_restore', 11:37:47 INFO - 'tabpaint']}, 11:37:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['a11yr', 11:37:47 INFO - 'ts_paint', 11:37:47 INFO - 'tpaint', 11:37:47 INFO - 'sessionrestore', 11:37:47 INFO - 'sessionrestore_no_auto_restore', 11:37:47 INFO - 'tabpaint']}, 11:37:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['a11yr', 11:37:47 INFO - 'ts_paint', 11:37:47 INFO - 'tpaint', 11:37:47 INFO - 'sessionrestore', 11:37:47 INFO - 'sessionrestore_no_auto_restore', 11:37:47 INFO - 'tabpaint']}, 11:37:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['a11yr', 11:37:47 INFO - 'ts_paint', 11:37:47 INFO - 'tpaint', 11:37:47 INFO - 'sessionrestore', 11:37:47 INFO - 'sessionrestore_no_auto_restore', 11:37:47 INFO - 'tabpaint']}, 11:37:47 INFO - 'other_l64': {'tests': ['a11yr', 11:37:47 INFO - 'ts_paint', 11:37:47 INFO - 'tpaint', 11:37:47 INFO - 'sessionrestore', 11:37:47 INFO - 'sessionrestore_no_auto_restore', 11:37:47 INFO - 'tabpaint']}, 11:37:47 INFO - 'other_nol64': {'tests': ['a11yr', 11:37:47 INFO - 'ts_paint', 11:37:47 INFO - 'tpaint', 11:37:47 INFO - 'sessionrestore', 11:37:47 INFO - 'sessionrestore_no_auto_restore', 11:37:47 INFO - 'tabpaint']}, 11:37:47 INFO - 'svgr': {'tests': ['tsvgx', 11:37:47 INFO - 'tsvgr_opacity', 11:37:47 INFO - 'tart', 11:37:47 INFO - 'tscrollx', 11:37:47 INFO - 'cart']}, 11:37:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['tsvgx', 11:37:47 INFO - 'tsvgr_opacity', 11:37:47 INFO - 'tart', 11:37:47 INFO - 'tscrollx', 11:37:47 INFO - 'cart']}, 11:37:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:47 INFO - 'tests': ['tp5o']}, 11:37:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:47 INFO - 'talos_options': ['--e10s'], 11:37:47 INFO - 'tests': ['tp5o']}, 11:37:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:47 INFO - 'talos_options': ['--xperf_path', 11:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:47 INFO - 'tests': ['tp5n']}, 11:37:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:47 INFO - 'talos_options': ['--e10s', 11:37:47 INFO - '--xperf_path', 11:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:47 INFO - 'tests': ['tp5n']}}, 11:37:47 INFO - 'talos.zip': {'path': '', 11:37:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:47 INFO - Running post-action listener: _resource_record_post_action 11:37:47 INFO - ##### 11:37:47 INFO - ##### Running create-virtualenv step. 11:37:47 INFO - ##### 11:37:47 INFO - Running pre-action listener: _resource_record_pre_action 11:37:47 INFO - Running main action method: create_virtualenv 11:37:47 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:47 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 11:37:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:37:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:47 INFO - Using real prefix '/usr' 11:37:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:47 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:49 INFO - Installing pip.................done. 11:37:49 INFO - Return code: 0 11:37:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:37:49 INFO - Using env: {'DISPLAY': ':0', 11:37:49 INFO - 'HOME': '/home/cltbld', 11:37:49 INFO - 'LANG': 'en_US.UTF-8', 11:37:49 INFO - 'LANGUAGE': 'en_US:en', 11:37:49 INFO - 'LOGNAME': 'cltbld', 11:37:49 INFO - 'MAIL': '/var/mail/cltbld', 11:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:49 INFO - 'MOZ_NO_REMOTE': '1', 11:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:49 INFO - 'NO_EM_RESTART': '1', 11:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:49 INFO - 'PWD': '/builds/slave/test', 11:37:49 INFO - 'SHELL': '/bin/bash', 11:37:49 INFO - 'SHLVL': '1', 11:37:49 INFO - 'TERM': 'linux', 11:37:49 INFO - 'TMOUT': '86400', 11:37:49 INFO - 'USER': 'cltbld', 11:37:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:49 INFO - '_': '/tools/buildbot/bin/python'} 11:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:50 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 11:37:50 INFO - Cleaning up... 11:37:50 INFO - Return code: 0 11:37:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:37:50 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')]} 11:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:50 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')]} 11:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:50 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 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:37:50 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 11:37:50 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 11:37:50 INFO - Using env: {'DISPLAY': ':0', 11:37:50 INFO - 'HOME': '/home/cltbld', 11:37:50 INFO - 'LANG': 'en_US.UTF-8', 11:37:50 INFO - 'LANGUAGE': 'en_US:en', 11:37:50 INFO - 'LOGNAME': 'cltbld', 11:37:50 INFO - 'MAIL': '/var/mail/cltbld', 11:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:50 INFO - 'MOZ_NO_REMOTE': '1', 11:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:50 INFO - 'NO_EM_RESTART': '1', 11:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:50 INFO - 'PWD': '/builds/slave/test', 11:37:50 INFO - 'SHELL': '/bin/bash', 11:37:50 INFO - 'SHLVL': '1', 11:37:50 INFO - 'TERM': 'linux', 11:37:50 INFO - 'TMOUT': '86400', 11:37:50 INFO - 'USER': 'cltbld', 11:37:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:50 INFO - '_': '/tools/buildbot/bin/python'} 11:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:50 INFO - Downloading/unpacking psutil>=0.7.1 11:37:50 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 11:37:50 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 11:37:50 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 11:37:50 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 11:37:50 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 11:37:50 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 11:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:52 INFO - Installing collected packages: psutil 11:37:52 INFO - Running setup.py install for psutil 11:37:52 INFO - building 'psutil._psutil_linux' extension 11:37:52 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 11:37:52 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 11:37:52 INFO - building 'psutil._psutil_posix' extension 11:37:52 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 11:37:52 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 11:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:52 INFO - Successfully installed psutil 11:37:52 INFO - Cleaning up... 11:37:52 INFO - Return code: 0 11:37:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:37:52 INFO - Using env: {'DISPLAY': ':0', 11:37:52 INFO - 'HOME': '/home/cltbld', 11:37:52 INFO - 'LANG': 'en_US.UTF-8', 11:37:52 INFO - 'LANGUAGE': 'en_US:en', 11:37:52 INFO - 'LOGNAME': 'cltbld', 11:37:52 INFO - 'MAIL': '/var/mail/cltbld', 11:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:52 INFO - 'MOZ_NO_REMOTE': '1', 11:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:52 INFO - 'NO_EM_RESTART': '1', 11:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:52 INFO - 'PWD': '/builds/slave/test', 11:37:52 INFO - 'SHELL': '/bin/bash', 11:37:52 INFO - 'SHLVL': '1', 11:37:52 INFO - 'TERM': 'linux', 11:37:52 INFO - 'TMOUT': '86400', 11:37:52 INFO - 'USER': 'cltbld', 11:37:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:52 INFO - '_': '/tools/buildbot/bin/python'} 11:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:37:54 INFO - Installing collected packages: mozsystemmonitor 11:37:54 INFO - Running setup.py install for mozsystemmonitor 11:37:55 INFO - Successfully installed mozsystemmonitor 11:37:55 INFO - Cleaning up... 11:37:55 INFO - Return code: 0 11:37:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:55 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 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:37:55 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 11:37:55 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 11:37:55 INFO - Using env: {'DISPLAY': ':0', 11:37:55 INFO - 'HOME': '/home/cltbld', 11:37:55 INFO - 'LANG': 'en_US.UTF-8', 11:37:55 INFO - 'LANGUAGE': 'en_US:en', 11:37:55 INFO - 'LOGNAME': 'cltbld', 11:37:55 INFO - 'MAIL': '/var/mail/cltbld', 11:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:55 INFO - 'MOZ_NO_REMOTE': '1', 11:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:55 INFO - 'NO_EM_RESTART': '1', 11:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:55 INFO - 'PWD': '/builds/slave/test', 11:37:55 INFO - 'SHELL': '/bin/bash', 11:37:55 INFO - 'SHLVL': '1', 11:37:55 INFO - 'TERM': 'linux', 11:37:55 INFO - 'TMOUT': '86400', 11:37:55 INFO - 'USER': 'cltbld', 11:37:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:55 INFO - '_': '/tools/buildbot/bin/python'} 11:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:37:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:37:57 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 11:37:57 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 11:37:57 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 11:37:57 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 11:37:57 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 11:37:57 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 11:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:37:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:37:57 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 11:37:57 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 11:37:57 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 11:37:57 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 11:37:57 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 11:37:57 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 11:37:57 INFO - Downloading docopt-0.6.1.tar.gz 11:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:37:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:37:57 INFO - Running setup.py install for blobuploader 11:37:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:37:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:37:57 INFO - Running setup.py install for requests 11:37:58 INFO - Running setup.py install for docopt 11:37:58 INFO - Successfully installed blobuploader requests docopt 11:37:58 INFO - Cleaning up... 11:37:58 INFO - Return code: 0 11:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:58 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')]} 11:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:58 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')]} 11:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:58 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 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:37:58 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 11:37:58 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 11:37:58 INFO - Using env: {'DISPLAY': ':0', 11:37:58 INFO - 'HOME': '/home/cltbld', 11:37:58 INFO - 'LANG': 'en_US.UTF-8', 11:37:58 INFO - 'LANGUAGE': 'en_US:en', 11:37:58 INFO - 'LOGNAME': 'cltbld', 11:37:58 INFO - 'MAIL': '/var/mail/cltbld', 11:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:58 INFO - 'MOZ_NO_REMOTE': '1', 11:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:37:58 INFO - 'NO_EM_RESTART': '1', 11:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:58 INFO - 'PWD': '/builds/slave/test', 11:37:58 INFO - 'SHELL': '/bin/bash', 11:37:58 INFO - 'SHLVL': '1', 11:37:58 INFO - 'TERM': 'linux', 11:37:58 INFO - 'TMOUT': '86400', 11:37:58 INFO - 'USER': 'cltbld', 11:37:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:58 INFO - '_': '/tools/buildbot/bin/python'} 11:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:58 INFO - Running setup.py (path:/tmp/pip-ElUIUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:58 INFO - Running setup.py (path:/tmp/pip-LTqmaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:58 INFO - Running setup.py (path:/tmp/pip-E8CTcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:58 INFO - Running setup.py (path:/tmp/pip-tDJE6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:58 INFO - Running setup.py (path:/tmp/pip-caCpUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:59 INFO - Running setup.py (path:/tmp/pip-iTSCHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:59 INFO - Running setup.py (path:/tmp/pip-7skTxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:59 INFO - Running setup.py (path:/tmp/pip-rCxqAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:59 INFO - Running setup.py (path:/tmp/pip-WmqYeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:59 INFO - Running setup.py (path:/tmp/pip-x8ZtGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:59 INFO - Running setup.py (path:/tmp/pip-4zhtY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:59 INFO - Running setup.py (path:/tmp/pip-D3rpVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:59 INFO - Running setup.py (path:/tmp/pip-a5pgSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:59 INFO - Running setup.py (path:/tmp/pip-70kBRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:59 INFO - Running setup.py (path:/tmp/pip-oosOWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:59 INFO - Running setup.py (path:/tmp/pip-AnrVAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:59 INFO - Running setup.py (path:/tmp/pip-ZtZnoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:37:59 INFO - Running setup.py install for manifestparser 11:38:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Running setup.py install for mozcrash 11:38:00 INFO - Running setup.py install for mozdebug 11:38:00 INFO - Running setup.py install for mozdevice 11:38:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Running setup.py install for mozfile 11:38:00 INFO - Running setup.py install for mozhttpd 11:38:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Running setup.py install for mozinfo 11:38:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Running setup.py install for mozInstall 11:38:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Running setup.py install for mozleak 11:38:00 INFO - Running setup.py install for mozlog 11:38:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:38:00 INFO - Running setup.py install for moznetwork 11:38:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:38:01 INFO - Running setup.py install for mozprocess 11:38:01 INFO - Running setup.py install for mozprofile 11:38:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:38:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:38:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:38:01 INFO - Running setup.py install for mozrunner 11:38:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:38:01 INFO - Running setup.py install for mozscreenshot 11:38:01 INFO - Running setup.py install for moztest 11:38:01 INFO - Running setup.py install for mozversion 11:38:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:38:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:38:01 INFO - Cleaning up... 11:38:01 INFO - Return code: 0 11:38:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:01 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 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:38:01 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 11:38:01 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 11:38:01 INFO - Using env: {'DISPLAY': ':0', 11:38:01 INFO - 'HOME': '/home/cltbld', 11:38:01 INFO - 'LANG': 'en_US.UTF-8', 11:38:01 INFO - 'LANGUAGE': 'en_US:en', 11:38:01 INFO - 'LOGNAME': 'cltbld', 11:38:01 INFO - 'MAIL': '/var/mail/cltbld', 11:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:01 INFO - 'MOZ_NO_REMOTE': '1', 11:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:01 INFO - 'NO_EM_RESTART': '1', 11:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:01 INFO - 'PWD': '/builds/slave/test', 11:38:01 INFO - 'SHELL': '/bin/bash', 11:38:01 INFO - 'SHLVL': '1', 11:38:01 INFO - 'TERM': 'linux', 11:38:01 INFO - 'TMOUT': '86400', 11:38:01 INFO - 'USER': 'cltbld', 11:38:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:01 INFO - '_': '/tools/buildbot/bin/python'} 11:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:38:01 INFO - Running setup.py (path:/tmp/pip-BneJJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:38:01 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)) 11:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:38:01 INFO - Running setup.py (path:/tmp/pip-nqzM7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:38:02 INFO - Running setup.py (path:/tmp/pip-Y7OWBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:38:02 INFO - Running setup.py (path:/tmp/pip-NIoqpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:38:02 INFO - Running setup.py (path:/tmp/pip-xoN9L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:38:02 INFO - Running setup.py (path:/tmp/pip-AsF6Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:38:02 INFO - Running setup.py (path:/tmp/pip-IWlXfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:38:02 INFO - Running setup.py (path:/tmp/pip-NxQeEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:38:02 INFO - Running setup.py (path:/tmp/pip-l0nAyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:38:02 INFO - Running setup.py (path:/tmp/pip-H1Rrxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:38:02 INFO - Running setup.py (path:/tmp/pip-Qy4r_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:38:02 INFO - Running setup.py (path:/tmp/pip-azGPOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:38:02 INFO - Running setup.py (path:/tmp/pip-c0VWxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:38:02 INFO - Running setup.py (path:/tmp/pip-beNYzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:02 INFO - Running setup.py (path:/tmp/pip-6vS81O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:02 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)) 11:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:38:02 INFO - Running setup.py (path:/tmp/pip-4N9_oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:38:03 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)) 11:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:38:03 INFO - Running setup.py (path:/tmp/pip-qLURQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:38:03 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)) 11:38:03 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)) 11:38:03 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)) 11:38:03 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)) 11:38:03 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)) 11:38:03 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)) 11:38:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:38:03 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 11:38:03 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 11:38:03 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 11:38:03 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 11:38:03 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 11:38:03 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 11:38:04 INFO - Downloading blessings-1.6.tar.gz 11:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:38:05 INFO - Installing collected packages: blessings 11:38:05 INFO - Running setup.py install for blessings 11:38:05 INFO - Successfully installed blessings 11:38:05 INFO - Cleaning up... 11:38:05 INFO - Return code: 0 11:38:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:05 INFO - Reading from file tmpfile_stdout 11:38:05 INFO - Current package versions: 11:38:05 INFO - argparse == 1.2.1 11:38:05 INFO - blessings == 1.6 11:38:05 INFO - blobuploader == 1.2.4 11:38:05 INFO - docopt == 0.6.1 11:38:05 INFO - manifestparser == 1.1 11:38:05 INFO - mozInstall == 1.12 11:38:05 INFO - mozcrash == 0.17 11:38:05 INFO - mozdebug == 0.1 11:38:05 INFO - mozdevice == 0.48 11:38:05 INFO - mozfile == 1.2 11:38:05 INFO - mozhttpd == 0.7 11:38:05 INFO - mozinfo == 0.9 11:38:05 INFO - mozleak == 0.1 11:38:05 INFO - mozlog == 3.1 11:38:05 INFO - moznetwork == 0.27 11:38:05 INFO - mozprocess == 0.22 11:38:05 INFO - mozprofile == 0.28 11:38:05 INFO - mozrunner == 6.11 11:38:05 INFO - mozscreenshot == 0.1 11:38:05 INFO - mozsystemmonitor == 0.0 11:38:05 INFO - moztest == 0.7 11:38:05 INFO - mozversion == 1.4 11:38:05 INFO - psutil == 3.1.1 11:38:05 INFO - requests == 1.2.3 11:38:05 INFO - wsgiref == 0.1.2 11:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:05 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 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:38:05 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 11:38:05 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 11:38:05 INFO - Using env: {'DISPLAY': ':0', 11:38:05 INFO - 'HOME': '/home/cltbld', 11:38:05 INFO - 'LANG': 'en_US.UTF-8', 11:38:05 INFO - 'LANGUAGE': 'en_US:en', 11:38:05 INFO - 'LOGNAME': 'cltbld', 11:38:05 INFO - 'MAIL': '/var/mail/cltbld', 11:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:05 INFO - 'MOZ_NO_REMOTE': '1', 11:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:05 INFO - 'NO_EM_RESTART': '1', 11:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:05 INFO - 'PWD': '/builds/slave/test', 11:38:05 INFO - 'SHELL': '/bin/bash', 11:38:05 INFO - 'SHLVL': '1', 11:38:05 INFO - 'TERM': 'linux', 11:38:05 INFO - 'TMOUT': '86400', 11:38:05 INFO - 'USER': 'cltbld', 11:38:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:05 INFO - '_': '/tools/buildbot/bin/python'} 11:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 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)) 11:38:05 INFO - Cleaning up... 11:38:05 INFO - Return code: 0 11:38:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:05 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 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:38:05 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 11:38:05 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 11:38:05 INFO - Using env: {'DISPLAY': ':0', 11:38:05 INFO - 'HOME': '/home/cltbld', 11:38:05 INFO - 'LANG': 'en_US.UTF-8', 11:38:05 INFO - 'LANGUAGE': 'en_US:en', 11:38:05 INFO - 'LOGNAME': 'cltbld', 11:38:05 INFO - 'MAIL': '/var/mail/cltbld', 11:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:05 INFO - 'MOZ_NO_REMOTE': '1', 11:38:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:05 INFO - 'NO_EM_RESTART': '1', 11:38:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:05 INFO - 'PWD': '/builds/slave/test', 11:38:05 INFO - 'SHELL': '/bin/bash', 11:38:05 INFO - 'SHLVL': '1', 11:38:05 INFO - 'TERM': 'linux', 11:38:05 INFO - 'TMOUT': '86400', 11:38:05 INFO - 'USER': 'cltbld', 11:38:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:05 INFO - '_': '/tools/buildbot/bin/python'} 11:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:05 INFO - Downloading/unpacking jsonschema 11:38:05 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 11:38:05 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 11:38:05 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 11:38:05 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 11:38:05 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 11:38:05 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 11:38:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:38:07 INFO - Downloading/unpacking functools32 (from jsonschema) 11:38: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 11:38: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 11:38: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 11:38: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 11:38: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 11:38: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 11:38:07 INFO - Downloading functools32-3.2.3-2.tar.gz 11:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:38:07 INFO - warning: no files found matching '*.txt' 11:38:07 INFO - no previously-included directories found matching 'build' 11:38:07 INFO - no previously-included directories found matching 'dist' 11:38:07 INFO - no previously-included directories found matching '.git*' 11:38:07 INFO - Installing collected packages: jsonschema, functools32 11:38:07 INFO - Running setup.py install for functools32 11:38:08 INFO - warning: no files found matching '*.txt' 11:38:08 INFO - no previously-included directories found matching 'build' 11:38:08 INFO - no previously-included directories found matching 'dist' 11:38:08 INFO - no previously-included directories found matching '.git*' 11:38:08 INFO - Successfully installed jsonschema functools32 11:38:08 INFO - Cleaning up... 11:38:08 INFO - Return code: 0 11:38:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:38:08 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')]} 11:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:08 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')]} 11:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:08 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 0x7f2d0956af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e7410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, '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': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', '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 11:38:08 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 11:38:08 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 11:38:08 INFO - Using env: {'DISPLAY': ':0', 11:38:08 INFO - 'HOME': '/home/cltbld', 11:38:08 INFO - 'LANG': 'en_US.UTF-8', 11:38:08 INFO - 'LANGUAGE': 'en_US:en', 11:38:08 INFO - 'LOGNAME': 'cltbld', 11:38:08 INFO - 'MAIL': '/var/mail/cltbld', 11:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:08 INFO - 'MOZ_NO_REMOTE': '1', 11:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:08 INFO - 'NO_EM_RESTART': '1', 11:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:08 INFO - 'PWD': '/builds/slave/test', 11:38:08 INFO - 'SHELL': '/bin/bash', 11:38:08 INFO - 'SHLVL': '1', 11:38:08 INFO - 'TERM': 'linux', 11:38:08 INFO - 'TMOUT': '86400', 11:38:08 INFO - 'USER': 'cltbld', 11:38:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:08 INFO - '_': '/tools/buildbot/bin/python'} 11:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:08 INFO - Downloading/unpacking flake8 11:38:08 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 11:38:08 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 11:38:08 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 11:38:08 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 11:38:08 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 11:38:08 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 11:38:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:38:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:38:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 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 11:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:38:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:38:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:38:10 INFO - no previously-included directories found matching 'docs/_build' 11:38:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:38:10 INFO - Running setup.py install for pep8 11:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:38:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:38:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:38:11 INFO - no previously-included directories found matching 'docs/_build' 11:38:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:38:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:38:11 INFO - Cleaning up... 11:38:11 INFO - Return code: 0 11:38:11 INFO - Running post-action listener: _resource_record_post_action 11:38:11 INFO - Running post-action listener: _start_resource_monitoring 11:38:11 INFO - Starting resource monitoring. 11:38:11 INFO - ##### 11:38:11 INFO - ##### Running install step. 11:38:11 INFO - ##### 11:38:11 INFO - Running pre-action listener: _resource_record_pre_action 11:38:11 INFO - Running main action method: install 11:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:11 INFO - Reading from file tmpfile_stdout 11:38:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:38:11 INFO - Reading from file tmpfile_stdout 11:38:11 INFO - Output received: 11:38:11 INFO - Usage: mozinstall [options] installer 11:38:11 INFO - Options: 11:38:11 INFO - -h, --help show this help message and exit 11:38:11 INFO - -d DEST, --destination=DEST 11:38:11 INFO - Directory to install application into. [default: 11:38:11 INFO - "/builds/slave/test"] 11:38:11 INFO - --app=APP Application being installed. [default: firefox] 11:38:11 INFO - mkdir: /builds/slave/test/build/application 11:38:11 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'] 11:38:11 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 11:38:27 INFO - Reading from file tmpfile_stdout 11:38:27 INFO - Output received: 11:38:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:38:27 INFO - Running post-action listener: _resource_record_post_action 11:38:27 INFO - ##### 11:38:27 INFO - ##### Running run-tests step. 11:38:27 INFO - ##### 11:38:27 INFO - Running pre-action listener: _resource_record_pre_action 11:38:27 INFO - Running main action method: run_tests 11:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:38:27 INFO - Python 2.7.3 11:38:27 INFO - Return code: 0 11:38:27 INFO - grabbing minidump binary from tooltool 11:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:38:27 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 0x2176160>, '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 0x2177060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21774f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:38:27 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 11:38:27 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 11:38:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:38:27 INFO - Return code: 0 11:38:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:38:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:38:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:38:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:38:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:38:28 INFO - Return code: 0 11:38:28 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/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:38:28 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/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 11:38:28 INFO - Using env: {'DISPLAY': ':0', 11:38:28 INFO - 'HOME': '/home/cltbld', 11:38:28 INFO - 'LANG': 'en_US.UTF-8', 11:38:28 INFO - 'LANGUAGE': 'en_US:en', 11:38:28 INFO - 'LOGNAME': 'cltbld', 11:38:28 INFO - 'MAIL': '/var/mail/cltbld', 11:38:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:38:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:28 INFO - 'MOZ_NO_REMOTE': '1', 11:38:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:38:28 INFO - 'NO_EM_RESTART': '1', 11:38:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:28 INFO - 'PWD': '/builds/slave/test', 11:38:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:38:28 INFO - 'SHELL': '/bin/bash', 11:38:28 INFO - 'SHLVL': '1', 11:38:28 INFO - 'TERM': 'linux', 11:38:28 INFO - 'TMOUT': '86400', 11:38:28 INFO - 'USER': 'cltbld', 11:38:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1457980653.878202-295749120', 11:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:28 INFO - '_': '/tools/buildbot/bin/python'} 11:38:28 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/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:38:28 INFO - mozversion application_buildid: 20160314103926 11:38:28 INFO - mozversion application_changeset: 2602e9da8592ce52e68a22203881ab238506cc94 11:38:28 INFO - mozversion application_display_name: Nightly 11:38:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:38:28 INFO - mozversion application_name: Firefox 11:38:28 INFO - mozversion application_remotingname: firefox 11:38:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:38:28 INFO - mozversion application_vendor: Mozilla 11:38:28 INFO - mozversion application_version: 48.0a1 11:38:28 INFO - mozversion platform_buildid: 20160314103926 11:38:28 INFO - mozversion platform_changeset: 2602e9da8592ce52e68a22203881ab238506cc94 11:38:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:38:28 INFO - mozversion platform_version: 48.0a1 11:38:28 INFO - using testdate: 1457980708 11:38:28 INFO - actual date: 1457980708 11:38:28 INFO - starting webserver on 'localhost:59526' 11:38:28 INFO - SUITE-START | Running 2 tests 11:38:28 INFO - TEST-START | dromaeo_css 11:38:28 INFO - operating with platform_type : linux_ 11:38:28 INFO - Initialising browser for dromaeo_css test... 11:38:28 INFO - TEST-INFO | started process 21806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwCuEfj/profile http://localhost:59526/getInfo.html) 11:38:33 INFO - PROCESS | 21806 | __metrics Screen width/height:1600/1200 11:38:33 INFO - PROCESS | 21806 | colorDepth:24 11:38:33 INFO - PROCESS | 21806 | Browser inner width/height: 1024/697 11:38:33 INFO - PROCESS | 21806 | __metrics 11:38:34 ERROR - PROCESS | 21806 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:38:34 INFO - TEST-INFO | 21806: exit 0 11:38:34 INFO - Browser initialized. 11:38:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:38:34 INFO - TEST-INFO | started process 21898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwCuEfj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:46 INFO - PROCESS | 21898 | RSS: Main: 154075136 11:38:46 INFO - PROCESS | 21898 | 11:39:38 INFO - PROCESS | 21898 | 1457980778127 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] 11:41:49 INFO - PROCESS | 21898 | Cycle 1(1): loaded http://localhost:59526/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59526/tests/dromaeo/cssquery-ext.html) 11:41:51 INFO - PROCESS | 21898 | RSS: Main: 274018304 11:41:51 INFO - PROCESS | 21898 | 11:44:53 INFO - PROCESS | 21898 | Cycle 1(1): loaded http://localhost:59526/tests/dromaeo/cssquery-ext.html (next: http://localhost:59526/tests/dromaeo/cssquery-jquery.html) 11:44:53 INFO - PROCESS | 21898 | RSS: Main: 245624832 11:44:53 INFO - PROCESS | 21898 | 11:47:55 INFO - PROCESS | 21898 | Cycle 1(1): loaded http://localhost:59526/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59526/tests/dromaeo/cssquery-mootools.html) 11:47:56 INFO - PROCESS | 21898 | RSS: Main: 234594304 11:47:56 INFO - PROCESS | 21898 | 11:50:58 INFO - PROCESS | 21898 | Cycle 1(1): loaded http://localhost:59526/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59526/tests/dromaeo/cssquery-prototype.html) 11:50:59 INFO - PROCESS | 21898 | RSS: Main: 224141312 11:50:59 INFO - PROCESS | 21898 | 11:54:01 INFO - PROCESS | 21898 | Cycle 1(1): loaded http://localhost:59526/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59526/tests/dromaeo/cssquery-yui.html) 11:54:02 INFO - PROCESS | 21898 | RSS: Main: 207687680 11:54:02 INFO - PROCESS | 21898 | 11:57:04 INFO - PROCESS | 21898 | Cycle 1(1): loaded http://localhost:59526/tests/dromaeo/cssquery-yui.html (next: http://localhost:59526/tests/dromaeo/cssquery-dojo.html) 11:57:05 INFO - PROCESS | 21898 | RSS: Main: 269340672 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - PROCESS | 21898 | __start_tp_report 11:57:05 INFO - PROCESS | 21898 | _x_x_mozilla_page_load 11:57:05 INFO - PROCESS | 21898 | _x_x_mozilla_page_load_details 11:57:05 INFO - PROCESS | 21898 | |i|pagename|runs| 11:57:05 INFO - PROCESS | 21898 | |0;dojo.html;2566.6406703061575;2670.7996900232474;2678.5848193529987;2681.9061332853353;2702.621632971384;4551.431071116111;4580.08398320336;4598.287265473853;4617.099665565216;4669.0428462165255;4630.606398456135;4654.255319148937;4655.4180727409075;4720.480747117815;4729.574338309551;4198.6011328923705;4204.411382406465;4227.196832601811;4258.850940217093;4358.1283743251315;4264.253755592759;4295.033617436083;4313.2451820931365;4315.50371707253;4363.258246098155;4154.896127596804;4157.688173386978;4223.155368926196;4226.619604235633;4231.682623803227;4235.004773878136;4245.702800803945;4247;4273.102648443831;4297.957020429787;4191.3293872980485;4224.683148763825;4239.385289133089;4256.787160641956;4279.40088387626;4425.491068527129;4499.527549607277;4533.093381323749;4568.794404251817;4574.222382195035;4857.562819346241;4900;4900.142475066885;4948.554630083274;4972.925406118911;4935.2843837643695;4938.407391113054;4941.530554597308;4946.826861059882;4947.975260123676;4543.568361005732;4576.725396476222;4630.32860235264;4670.299455081697;4674.462436819741;5051.040302342543;5052.292679024939;5068.721220332844;5080.847574572768;5123.948760512347;4863.708177509361;4868.9756551217015;4871.732054737024;4876.609871210295;4921.532454416824;4851.878703032452;4902.90194196114;4936.062148191904;4981;4981.277714731344;4882.340883980688;4902.754862256873;4903.681260718042;4914.557689807934;4947.431045429749;4781.976090119527;4895.485973972753;4897.534734200245;4908.190148625508;4946.579540739005;4124.401961715595;4128.60778226068;4172.186423647359;4175.874723758231;4182.079942412725;3627.05696518907;3629.8366573504254;3632.2553876455263;3649.543807024122;3676.3198808220563;4281.464816897887;4282.143571285693;4282.807273672693;4289.399484072233;4323.935140972888;4841.636877234221;4870.318155458239;4887.29134275528;4906.362172917497;4926.211806111077;4271.615554600039;4273.059926816096;4275.893102672458;4277.721948073366;4319.244132276839;4362.0839623679385;4387.232234358974;4400.251957167289;4455.220336441174;4472.619827314649;4699.882502937454;4727.479977202436;4731.053789242234;4765.237561990065;4773.212419950669;4944.184209605519;4965.4041515018425;4967.925481117713;4974.477679843564;5008.474110218374;4624.583787459145;4626.722396656077;4726.172919738963;4729.935764452971;4774.594159496482;4830.275458681226;4843.515648435128;4845.248986407112;4869.683470574401;4890;4905.852824415273;4907.386576677915;4908.484609115992;4923.458419573915;4971.577415919687;4709.576138147583;4788.042391521779;4788.186008378514;4839.782209800638;4854.83008094715;4762.880927976828;4772.0694464580465;4777;4814.037192561572;4830.903381932412;4719.268513380294;4723.976380118077;4726.078414709099;4753.667243292936;4766.571008609242;4747.667663263538;4759.190937540558;4786.617070634411;4799.160146974195;4822.662413631012;4693.131770622445;4723.4331880174595;4723.976380118077;4725.645576581839;4751.83368582098 11:57:05 INFO - PROCESS | 21898 | |1;ext.html;530.6948504609849;531.7367902888069;548.8847342058168;551.8316913341432;553.4797290546888;27255.454890902194;34239;35536.822315888414;35569.46645800309;35583.288334233366;38262.42606360907;38923.221535569275;38937.22125557494;38963.22073558527;38978.41532377017;7594.354479869217;7768.339691126261;7773.533587984711;7774.222577742237;7777.10563285221;7579.279968402993;7693.8076548086465;7696.846063078735;7700.306972372486;7882.881756773624;7837.216278372174;7905.881411778799;7905.920940790576;7907.683692652287;7909.96045019777;7778.5721785301785;7837.294643482057;7877.881831772528;7884.093329267093;7889.092754333267;7714.4214183935865;7873.8031549211155;7874.173211812735;7875;7876.527408355517;38349.80825095884;38775.80612096949;38789.61210387917;38810.80594597009;38812;3247.7401807855313;3295.8516866741056;3532.364174448598;3714.851405943759;3806.4290356446477;29656.40687186244;30201.09396718102;30360;30615.38769224603;30832.38335233283;3292;3330.4837750148768;3338.549295845054;3349.7822641528223;3385.0691059958463;255642;292115;296442;296527;297399.66902151506;53609;54028.45971540313;54106;54115.91768164615;54300;58007.419925800205;64569.35430645727;66120.33879661238;66124.6693766528;66146.66926665336;15136.394544218108;15405.691886162214;15419.460318888785;15423.614409639624;15429.30568124437;11671.88328116708;11838.230515016496;11845;11847.111466640037;11847.170698051226;19573.21707131727;19928.60142797136;20551.280705175246;20734.170633174504;20779.792202077784;7793;7985.560794156378;7999.9600001999615;8090.635921383552;8099.595020249082;877.8770972063916;884.3897710579679;903.746950853762;923.3351986569659;949.7055912667096;26675.733242667713;27692;29377;31044.53433198504;31262;972.7665360313474;988.2736188901152;994.6170724271063;1037.0459177556666;1037.1702637889657;13706.65733356674;14043.368048437846;14255.572332830032;14289.714205716036;14298.714025719428;373875;375379;380124;380183;380349;48480.75759621179;48794.75602621964;49329;49442.75278623584;49443;1203.2239205712267;1215.2283300104498;1233.2477188914754;1272.1603741530546;1274.8852603265566;25819.354516136496;27634.447311054068;27660;27812.44375112527;28146.71853281523;38366.42450363191;38732;38732.41901371538;38787;39203.21593568056;204354;204624;205533;206022;206026;26089.478210436064;30513.38973220479;30552.84723576368;30571.23571910631;30588.847055764578;33615.66384336125;34277.82861085778;34692;34724.47913281252;34778.30443391169;30154.24614384658;30256;30586.694133059274;30790.846045769627;30996.69003309938;29999.400012000075;30452.543211852284;30674.233144171576;30724.231894202825;33204.50193247055;32549.674503254664;32652.83673581617;33189.668103318654;33223.501647475794;33232.33535329328;29369.265768355963;29697.70302297036;29706.702932971257;29740.256493587833;29778.702212977594;23109.653355200022;23335;23348.76651233466;23582;23582 11:57:05 INFO - PROCESS | 21898 | |2;jquery.html;354.1624059100227;359.14702581369244;362.2085742652304;367.40480421716825;370.4313878196968;15635.609109772262;15906.840931590696;16343.509694709148;16759.329626814913;16824.158792060378;15974.201289935514;16105.919470402632;16649.1675416229;16650.75023874643;16665.33338666452;4860.416749990006;4919.557239848404;4991.425986011601;4995.900081998358;5049.621278404116;4937.753112344386;5006.724630145341;5011.473795251501;5018.523240292185;5038.445770965191;4918.754062296871;4962;4964.304997300381;4977.228529577921;5000.749962501878;4879.316895634614;4980.477049909761;5003.8991421887495;5021.17150670139;5029.270755740416;4468.151051300275;4481.35020422037;4493.977530112328;4510.548945105464;4512.210363186462;18331.45005649833;19367.51581210467;19588.70616940747;19628.313009044614;19630.214791408325;1929.8552608554273;1945.873518221311;1982.821546060847;2095.738032745907;2404.603240465321;12425.378731063502;12488.12583119182;12598;12641.367931603383;12729.172603780817;1728.08411541883;1769.3453422233856;1784.8661350398772;1792.2741289777662;1793.7040388335909;56679;58523.707381463246;61202.38797612012;62747;65359.3464065358;9860.16188623975;10049.69850904474;10139.138173255209;10143.949280253699;10282.07461328484;12911.096223264281;13021.739565208833;13034.348282585834;13041.478340866448;13074.346282685829;7431.777046688608;7489.400847932152;7557.206493318123;7584.962075189699;7653.846923061507;7280.854382912418;7364.374028207555;7463.141738700119;7473.4021278297605;7479.401647868266;4306.0526684129445;4340.76125813077;4367.973526221335;4415.094905544356;4417.823287068545;1743.9825601744074;1759.3314540474537;1766.1522469214592;1787.9821201788077;1798.7751531058618;859.110820300998;871.0542726201871;887.8357503861806;920.8710780490736;958.3195930889008;15696.92151539235;15755.212239387985;15864.286107125206;16072.758908616146;16168.27242774078;845.5287799229296;862.2369203255164;873.8776571280026;886.7118186589385;915.8443064678887;8928.508932008672;9038.322125840588;9140;9316.301277404222;9429.76425589352;401658;421272;426688;433178;438221;65249.34750652528;67431;67663.27851968189;69232.30767692359;69571.65214173897;963.7638778499313;964.6864768949979;964.9372790768577;965.9758506037265;968.5205823117602;13774.65563360924;13873.4450621974;14124.223167725873;14173.574792756233;14315.928420357832;32700.83649581737;33547.83226083854;33696.15759606029;33737;33871.83064084664;45044.54955450403;45814.77092614515;45936.54063459457;45955;46224.07551849011;7416.4066874648815;7425.517341372793;7451.3293803557945;7563.546187228784;7573.35626471756;8821.691240806542;11174.72063198394;11202.775944481227;11233.101351891992;11276.097912167172;9222.723318300461;9454.858177127486;9516.286278529;9540.427574345562;9572.329936904629;9149;9830.557624906753;9843.261755368232;9932.354396964174;9995.750106247111;9526.285528585246;9560.378575392577;9654.131128198496;9744.951275243578;9871.901280987098;7299.671514781741;7385.076865391826;7397.926020739724;7421.406287497095;7498.58757768328;8145.51126932386;8892.199702026848;9684.757881052748;9764.511774411392;10051.447170405405 11:57:05 INFO - PROCESS | 21898 | |3;mootools.html;1309.9476020959162;1418.531884478122;1436.4613270023738;1606.148741167181;1806.801251862295;6928.099347084878;7121.572705637665;7149.106361704787;7161.140663120426;7173.928260717391;7019.859602807941;7217.81955451114;7223.205447400795;7225.349718525332;7233.927660723404;1914.731937528747;2161.9891900540474;2182.0835249195297;2208.900599473028;2237.451824303048;2239.0819763896807;2243.753187149412;2250.9212177573786;2252.7409347924954;2253.256425379629;2147.4846036951176;2234.106357457022;2234.625705191304;2236.0720301075035;2236.586231547161;2194.1662168376074;2195.078067211775;2208.7349518057854;2248.9662655060188;2258.0516183203094;2189.8905054747197;2219.4895174110047;2222.466608014081;2223.7331520217676;2244.943876403103;7302.853942921111;7369.668364923591;7371.483996120273;7373.77878663641;7385.335319821188;4531.252343363341;4621.168189725848;4648.721076735406;4658.650601204923;4664.5335466453425;2915.489789286866;2929.8095623784384;2975.851207439641;2978.6723460419335;3066.6779988101152;899.0649724286799;903.814717982812;915.2860768600435;924.7919218175924;941.637469574212;10002.399856008662;10056.648017319432;10082.848757268646;10087.899121008842;10092;4150.833966641361;4240.766757828349;4309.827606895752;4332.133573285356;4334.631556317749;8590.484570925764;8656.697015604424;8678.132186781271;8683.435576687496;8691.261242794433;4058.188362327546;4520.50274469808;4525.502194758574;4532.773361331986;4535.9773201133785;3729.030452082478;3765.8870233893026;4073.368627862686;4170.895727606834;4184.853530126492;3688.3176612326806;3706.129059670975;3759.266942946154;3782.905427364283;3786.753860999026;1196.5692350753723;1197.22180582622;1207.124834494984;1209.9697507562382;1230.341767154568;1017.893121222261;1029.2743615750878;1184.0527577937617;1184.1888306510068;1209.2804781155198;6761.932380676229;6804.9319506804295;6827.897581536281;6859.519833611699;6879.140107486564;473.27116240988494;479.37681014680777;481.41267653462717;485.6915858429852;486.4940461919635;5012.198048312325;5050.292958985745;5054.444011158843;5070.442251352349;5089.414717307557;8231.670733170726;8320.37597180214;8448.83102337962;8799.780005499913;8834.381593288408;8645.610947507377;8688.435251708619;8689;8750.781230469289;8763.430377025474;6664.700088496029;6801.795946121624;6851.9657401712675;6883.105196324445;6884.311568843075;6356.300806911328;6382.96808515973;6403.231612206565;6423.743050277936;6431.324710905287;7629.542227466148;7698.730544430918;7707.306342429209;7722.073351197892;7732.110807257012;7600.859871019391;7903.012123484565;8007.639656215368;8009.519428834055;8014.519128852287;5599.552035837205;5731.942680573141;5740.885182296247;6188.1027251049245;6251.437370636664;6064.272287325549;6895.172579290517;6911.481638877004;6922.757703480354;6938.375546200866;6207.131001659681;6219.0982307566055;6304.464120549805;6339.524535659752;6354.841128971812;6019.337872834072;6165.10605962124;6169.81490555284;6253.062040693932;6261.906071409024;6336.081268216175;6394.968025159845;6404.615723056631;6522.380373864476;6560.048792924904;6152.600080994721;6183.3816618337805;6196.752129914753;6199.442050215503;6200.379962003944;5925.1704761332585;6065.363136870565;6065.423784740443;6071.969640151948;6086.817395478142 11:57:05 INFO - PROCESS | 21898 | |4;prototype.html;320.2170692656456;320.67932067932065;325.2632786738037;327.4907518808253;328.51543972640343;5362.946370536293;5389.299391079159;5392.056390131731;5437.293151890259;5459.535939445152;5332;5339.038972984861;5344.812931547397;5348.117560602496;5369.9463005369935;3983.760974341534;4099.938500922489;4183.832646694136;4191.832326706928;4230.302000169968;4192.161567686459;4210.768407737573;4216.51510076342;4221.725587836796;4227.640650544692;4187.204431158086;4190.371444283352;4191.266528357541;4191.517975432834;4204.621584057434;3928.764274143546;4046.494188226457;4162.666986641092;4193.874183774492;4204.369344598304;3715.5727091384565;3718.8698395556025;3723.553173619183;3727.683146932514;3734.458503517002;5135.948640513584;5158.019976204547;5163.793448262065;5164.302819119408;5167.48325167484;4848.29699693546;4864.318995340655;4865.6107511399005;4867.099586576459;4869.172240719086;5658.7170641467765;5665.036943719578;5674.687892165929;5676.460736230051;5680.261565996435;3989.0101730155425;4089.5297040840087;4098.4876890388705;4102.50769907613;4110.034141976633;5858.677772722499;5933.673647949361;5934.198883150762;5943.4056594340655;5955.642661440327;4184.727992680466;4206.896551724138;4208.726432781859;4210.157968406331;4210.347396153601;4253.404523366731;4269.23153832307;4271;4274.465691788527;4275.572442755762;4808.471068182497;4828.179209534387;4829.66192366531;4831.154547954094;4838.782254798542;5660.037793575102;5669.688167150764;5670.404607516151;5676.68778217202;5680.573956953245;1390.6870954035262;1467.031759039029;1493.8132733408324;1495.5812372535706;1497.6779992301708;864.429476545477;951.2485136741897;953.7520244736419;972.2367941166151;983.1593987140892;4981.427135879348;4998.725070121105;5000.299958005882;5009.874753131201;5011.298418221452;5836.066229403275;5893.263342082239;5898.115282707542;5898.144769008555;5899.203607513016;4965.453800081988;4994.40067191932;4997.600191984632;5006.6495345325475;5007.624428167902;3088.6911308869385;3122.9063128106195;3124.328269422085;3126.906192814219;3130.092273240735;5466.726663666801;5477.370102438191;5500.50495455411;5505.862353441196;5515.25544051556;5816.272965879265;5991.4907232884825;6088.939110608926;6093.11649810775;6101.664408457577;5584.9388616163615;5595.63628364155;5601.579881508822;5619.8876022480135;5620.775168993195;5914.556408269311;5918.112283157561;5926.762929482772;5932.525397968238;5938.584299099021;5787.681677507778;5791.507721843691;5798.275215598051;5799.159121927381;5806.622569532967;5376.650517716336;5581.190727344431;5589.664620122806;5596.076647353141;5597.776088956396;3959.5248570171766;3969.8412063517135;3971.0667993022194;3983.203359328088;3986.1031267965636;5891.05743081105;5892.351841297368;5897.941020589739;5898.734556945034;5903.409659034234;5688.175214593778;5701.686407247641;5701.857453563694;5702.5437964961875;5705.429457054262;5696.658200507983;5699.857503562444;5701.657900525982;5705.144228365778;5708.229389032427;5368.087425137658;5553.611247212656;5598.692071936082;5604.495595396434;5608.990381731328;5645.576581756302;5668.2064510967675;5675.460831221028;5679.17651940458;5681.545476361964;5508.7521061553125;5607.383187849252;5614.606977511535;5615.691136987505;5616.382197958303 11:57:05 INFO - PROCESS | 21898 | |5;yui.html;622.5953130465199;721.1346384338789;769.5267410542516;777.8094366880111;785.2932360875216;11459.770804583903;11658.125640576949;11668.41657917104;11679.474423650934;11682.0070294025;10970.780584388307;10991.230613857033;11015.614453494129;11097.83353249702;11114.777704445927;780.8906753054563;799.4963173200904;803.4978138663336;804.3645520039162;804.9074356449024;641.1344684675697;791.0665414810521;808.3937047214589;812.6424373275739;815.8613035783931;850.7617866997251;855.3969451536683;856.867185586232;857.2670366836359;857.3526987124712;673.3300366135677;844.1895780051158;851.4720873058712;851.5954921412341;852.2074470742207;621.4531212532942;628.4909223528956;632.250782822357;632.3802673380113;632.686820024091;11825.586104486387;12084.879151208463;12095.576654817127;12108.57619983305;12152.513899444011;12264.325462099581;12783.360831958365;12995.610131696065;13086.937927056082;13211.867881321159;10002.649907253284;10080.69757907264;10101.19190464761;10220.437875916821;10230.386176829414;3261.983690081558;3270.051685011344;3316.9004929851903;3389.3390788796196;3408.590969083701;47535;47645.76177119127;47688.28467572989;47779;49050.26424603598;10329.948350258352;10440.269181157399;10492.842607360895;10497.527611257512;10587.735306617242;17504.037277949836;17916.462506124837;17916.820831791774;17930.91034544819;17951.640967180585;6732.192136943598;6768.7292508299115;6822.692978815965;6895.034695142684;6905.447564194852;3879.7478163919254;3959;3978.2839088964265;3992.5807790182193;4009.69927255457;2741.849198294073;2766.1839757271655;2780;2785.220138361262;2789.246903336088;502.36200025966815;502.7285265956416;506.8910184310391;517.0021857814454;517.3533083645443;446.74312270444625;537.5028099008401;548.569373042168;551.8730691940796;566.487328967277;7266.600336981517;7379.2251813558805;7449.329560339487;7588.696452141963;7660.387169026464;493.6593750312273;561.5227057001516;575.0368133376578;611.400827189357;625.0780099353417;3497;3612.674859262679;3651.415773476231;3664.3770559005034;3702.777833330009;55964.44035559674;56646.71676641673;57400.712996435585;57525;57594.7120264396;48520;48840;49066.264006039935;49145.50854491409;49195.262071068966;43469;44656.55343446589;44703.32945005828;44755;44975.775121124185;7032.437405007485;7101;7135.429165666838;7173.10336207974;7245.637718113968;35134.64865351314;35220.47169292514;35232.29535409329;36322.091947700465;36323.81838090793;40414.393784092674;41258;42311;45059.54940450554;45242.09515809731;10494.68515944523;10507.684769456928;10646.89353106459;10651;10705.411202383631;10917.181211409017;11119.944400277947;11183.832242516206;11568.24806387582;11655.76688466243;10891.18316126278;11084.390358530358;11150.553977840795;11182.944085279521;11276.548938042386;11558.30650160993;11880;11971.760564788481;12071.275723456269;12275;11091;11372.033377162703;11535.134864885;11692.766144677229;11721.824172637247;9229.907700922904;9356.251499879858;9545.379550329206;9641.758956025875;9681.128698416895;8666.393352465268;9291.581878815334;9595.616175352907;9675.467849268358;9682.361454200494 11:57:05 INFO - PROCESS | 21898 | __end_tp_report 11:57:05 INFO - PROCESS | 21898 | __start_cc_report 11:57:05 INFO - PROCESS | 21898 | _x_x_mozilla_cycle_collect,1063 11:57:05 INFO - PROCESS | 21898 | __end_cc_report 11:57:05 INFO - PROCESS | 21898 | __startTimestamp1457981825185__endTimestamp 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - PROCESS | 21898 | ------- Summary: start ------- 11:57:05 INFO - PROCESS | 21898 | Number of tests: 6 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - PROCESS | 21898 | [#0] dojo.html Cycles:165 Average:4562.84 Median:4723.98 stddev:465.21 (9.8%) stddev-sans-first:439.49 11:57:05 INFO - PROCESS | 21898 | Values: 2566.6 2670.8 2678.6 2681.9 2702.6 4551.4 4580.1 4598.3 4617.1 4669.0 4630.6 4654.3 4655.4 4720.5 4729.6 4198.6 4204.4 4227.2 4258.9 4358.1 4264.3 4295.0 4313.2 4315.5 4363.3 4154.9 4157.7 4223.2 4226.6 4231.7 4235.0 4245.7 4247.0 4273.1 4298.0 4191.3 4224.7 4239.4 4256.8 4279.4 4425.5 4499.5 4533.1 4568.8 4574.2 4857.6 4900.0 4900.1 4948.6 4972.9 4935.3 4938.4 4941.5 4946.8 4948.0 4543.6 4576.7 4630.3 4670.3 4674.5 5051.0 5052.3 5068.7 5080.8 5123.9 4863.7 4869.0 4871.7 4876.6 4921.5 4851.9 4902.9 4936.1 4981.0 4981.3 4882.3 4902.8 4903.7 4914.6 4947.4 4782.0 4895.5 4897.5 4908.2 4946.6 4124.4 4128.6 4172.2 4175.9 4182.1 3627.1 3629.8 3632.3 3649.5 3676.3 4281.5 4282.1 4282.8 4289.4 4323.9 4841.6 4870.3 4887.3 4906.4 4926.2 4271.6 4273.1 4275.9 4277.7 4319.2 4362.1 4387.2 4400.3 4455.2 4472.6 4699.9 4727.5 4731.1 4765.2 4773.2 4944.2 4965.4 4967.9 4974.5 5008.5 4624.6 4626.7 4726.2 4729.9 4774.6 4830.3 4843.5 4845.2 4869.7 4890.0 4905.9 4907.4 4908.5 4923.5 4971.6 4709.6 4788.0 4788.2 4839.8 4854.8 4762.9 4772.1 4777.0 4814.0 4830.9 4719.3 4724.0 4726.1 4753.7 4766.6 4747.7 4759.2 4786.6 4799.2 4822.7 4693.1 4723.4 4724.0 4725.6 4751.8 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - PROCESS | 21898 | [#1] ext.html Cycles:180 Average:44610.62 Median:18812.03 stddev:78725.33 (418.5%) stddev-sans-first:78876.60 11:57:05 INFO - PROCESS | 21898 | Values: 530.7 531.7 548.9 551.8 553.5 27255.5 34239.0 35536.8 35569.5 35583.3 38262.4 38923.2 38937.2 38963.2 38978.4 7594.4 7768.3 7773.5 7774.2 7777.1 7579.3 7693.8 7696.8 7700.3 7882.9 7837.2 7905.9 7905.9 7907.7 7910.0 7778.6 7837.3 7877.9 7884.1 7889.1 7714.4 7873.8 7874.2 7875.0 7876.5 38349.8 38775.8 38789.6 38810.8 38812.0 3247.7 3295.9 3532.4 3714.9 3806.4 29656.4 30201.1 30360.0 30615.4 30832.4 3292.0 3330.5 3338.5 3349.8 3385.1 255642.0 292115.0 296442.0 296527.0 297399.7 53609.0 54028.5 54106.0 54115.9 54300.0 58007.4 64569.4 66120.3 66124.7 66146.7 15136.4 15405.7 15419.5 15423.6 15429.3 11671.9 11838.2 11845.0 11847.1 11847.2 19573.2 19928.6 20551.3 20734.2 20779.8 7793.0 7985.6 8000.0 8090.6 8099.6 877.9 884.4 903.7 923.3 949.7 26675.7 27692.0 29377.0 31044.5 31262.0 972.8 988.3 994.6 1037.0 1037.2 13706.7 14043.4 14255.6 14289.7 14298.7 373875.0 375379.0 380124.0 380183.0 380349.0 48480.8 48794.8 49329.0 49442.8 49443.0 1203.2 1215.2 1233.2 1272.2 1274.9 25819.4 27634.4 27660.0 27812.4 28146.7 38366.4 38732.0 38732.4 38787.0 39203.2 204354.0 204624.0 205533.0 206022.0 206026.0 26089.5 30513.4 30552.8 30571.2 30588.8 33615.7 34277.8 34692.0 34724.5 34778.3 30154.2 30256.0 30586.7 30790.8 30996.7 29999.4 30452.5 30674.2 30724.2 33204.5 32549.7 32652.8 33189.7 33223.5 33232.3 29369.3 29697.7 29706.7 29740.3 29778.7 23109.7 23335.0 23348.8 23582.0 23582.0 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - PROCESS | 21898 | [#2] jquery.html Cycles:180 Average:24315.21 Median:4899.04 stddev:69534.57 (1419.4%) stddev-sans-first:69706.35 11:57:05 INFO - PROCESS | 21898 | Values: 354.2 359.1 362.2 367.4 370.4 15635.6 15906.8 16343.5 16759.3 16824.2 15974.2 16105.9 16649.2 16650.8 16665.3 4860.4 4919.6 4991.4 4995.9 5049.6 4937.8 5006.7 5011.5 5018.5 5038.4 4918.8 4962.0 4964.3 4977.2 5000.7 4879.3 4980.5 5003.9 5021.2 5029.3 4468.2 4481.4 4494.0 4510.5 4512.2 18331.5 19367.5 19588.7 19628.3 19630.2 1929.9 1945.9 1982.8 2095.7 2404.6 12425.4 12488.1 12598.0 12641.4 12729.2 1728.1 1769.3 1784.9 1792.3 1793.7 56679.0 58523.7 61202.4 62747.0 65359.3 9860.2 10049.7 10139.1 10143.9 10282.1 12911.1 13021.7 13034.3 13041.5 13074.3 7431.8 7489.4 7557.2 7585.0 7653.8 7280.9 7364.4 7463.1 7473.4 7479.4 4306.1 4340.8 4368.0 4415.1 4417.8 1744.0 1759.3 1766.2 1788.0 1798.8 859.1 871.1 887.8 920.9 958.3 15696.9 15755.2 15864.3 16072.8 16168.3 845.5 862.2 873.9 886.7 915.8 8928.5 9038.3 9140.0 9316.3 9429.8 401658.0 421272.0 426688.0 433178.0 438221.0 65249.3 67431.0 67663.3 69232.3 69571.7 963.8 964.7 964.9 966.0 968.5 13774.7 13873.4 14124.2 14173.6 14315.9 32700.8 33547.8 33696.2 33737.0 33871.8 45044.5 45814.8 45936.5 45955.0 46224.1 7416.4 7425.5 7451.3 7563.5 7573.4 8821.7 11174.7 11202.8 11233.1 11276.1 9222.7 9454.9 9516.3 9540.4 9572.3 9149.0 9830.6 9843.3 9932.4 9995.8 9526.3 9560.4 9654.1 9745.0 9871.9 7299.7 7385.1 7397.9 7421.4 7498.6 8145.5 8892.2 9684.8 9764.5 10051.4 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - PROCESS | 21898 | [#3] mootools.html Cycles:180 Average:5067.37 Median:6064.82 stddev:2596.64 (42.8%) stddev-sans-first:2588.56 11:57:05 INFO - PROCESS | 21898 | Values: 1309.9 1418.5 1436.5 1606.1 1806.8 6928.1 7121.6 7149.1 7161.1 7173.9 7019.9 7217.8 7223.2 7225.3 7233.9 1914.7 2162.0 2182.1 2208.9 2237.5 2239.1 2243.8 2250.9 2252.7 2253.3 2147.5 2234.1 2234.6 2236.1 2236.6 2194.2 2195.1 2208.7 2249.0 2258.1 2189.9 2219.5 2222.5 2223.7 2244.9 7302.9 7369.7 7371.5 7373.8 7385.3 4531.3 4621.2 4648.7 4658.7 4664.5 2915.5 2929.8 2975.9 2978.7 3066.7 899.1 903.8 915.3 924.8 941.6 10002.4 10056.6 10082.8 10087.9 10092.0 4150.8 4240.8 4309.8 4332.1 4334.6 8590.5 8656.7 8678.1 8683.4 8691.3 4058.2 4520.5 4525.5 4532.8 4536.0 3729.0 3765.9 4073.4 4170.9 4184.9 3688.3 3706.1 3759.3 3782.9 3786.8 1196.6 1197.2 1207.1 1210.0 1230.3 1017.9 1029.3 1184.1 1184.2 1209.3 6761.9 6804.9 6827.9 6859.5 6879.1 473.3 479.4 481.4 485.7 486.5 5012.2 5050.3 5054.4 5070.4 5089.4 8231.7 8320.4 8448.8 8799.8 8834.4 8645.6 8688.4 8689.0 8750.8 8763.4 6664.7 6801.8 6852.0 6883.1 6884.3 6356.3 6383.0 6403.2 6423.7 6431.3 7629.5 7698.7 7707.3 7722.1 7732.1 7600.9 7903.0 8007.6 8009.5 8014.5 5599.6 5731.9 5740.9 6188.1 6251.4 6064.3 6895.2 6911.5 6922.8 6938.4 6207.1 6219.1 6304.5 6339.5 6354.8 6019.3 6165.1 6169.8 6253.1 6261.9 6336.1 6395.0 6404.6 6522.4 6560.0 6152.6 6183.4 6196.8 6199.4 6200.4 5925.2 6065.4 6065.4 6072.0 6086.8 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - PROCESS | 21898 | [#4] prototype.html Cycles:180 Average:4722.31 Median:5369.02 stddev:1381.54 (25.7%) stddev-sans-first:1345.32 11:57:05 INFO - PROCESS | 21898 | Values: 320.2 320.7 325.3 327.5 328.5 5362.9 5389.3 5392.1 5437.3 5459.5 5332.0 5339.0 5344.8 5348.1 5369.9 3983.8 4099.9 4183.8 4191.8 4230.3 4192.2 4210.8 4216.5 4221.7 4227.6 4187.2 4190.4 4191.3 4191.5 4204.6 3928.8 4046.5 4162.7 4193.9 4204.4 3715.6 3718.9 3723.6 3727.7 3734.5 5135.9 5158.0 5163.8 5164.3 5167.5 4848.3 4864.3 4865.6 4867.1 4869.2 5658.7 5665.0 5674.7 5676.5 5680.3 3989.0 4089.5 4098.5 4102.5 4110.0 5858.7 5933.7 5934.2 5943.4 5955.6 4184.7 4206.9 4208.7 4210.2 4210.3 4253.4 4269.2 4271.0 4274.5 4275.6 4808.5 4828.2 4829.7 4831.2 4838.8 5660.0 5669.7 5670.4 5676.7 5680.6 1390.7 1467.0 1493.8 1495.6 1497.7 864.4 951.2 953.8 972.2 983.2 4981.4 4998.7 5000.3 5009.9 5011.3 5836.1 5893.3 5898.1 5898.1 5899.2 4965.5 4994.4 4997.6 5006.6 5007.6 3088.7 3122.9 3124.3 3126.9 3130.1 5466.7 5477.4 5500.5 5505.9 5515.3 5816.3 5991.5 6088.9 6093.1 6101.7 5584.9 5595.6 5601.6 5619.9 5620.8 5914.6 5918.1 5926.8 5932.5 5938.6 5787.7 5791.5 5798.3 5799.2 5806.6 5376.7 5581.2 5589.7 5596.1 5597.8 3959.5 3969.8 3971.1 3983.2 3986.1 5891.1 5892.4 5897.9 5898.7 5903.4 5688.2 5701.7 5701.9 5702.5 5705.4 5696.7 5699.9 5701.7 5705.1 5708.2 5368.1 5553.6 5598.7 5604.5 5609.0 5645.6 5668.2 5675.5 5679.2 5681.5 5508.8 5607.4 5614.6 5615.7 5616.4 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - PROCESS | 21898 | [#5] yui.html Cycles:180 Average:13322.84 Median:44679.94 stddev:15652.85 (35.0%) stddev-sans-first:15667.71 11:57:05 INFO - PROCESS | 21898 | Values: 622.6 721.1 769.5 777.8 785.3 11459.8 11658.1 11668.4 11679.5 11682.0 10970.8 10991.2 11015.6 11097.8 11114.8 780.9 799.5 803.5 804.4 804.9 641.1 791.1 808.4 812.6 815.9 850.8 855.4 856.9 857.3 857.4 673.3 844.2 851.5 851.6 852.2 621.5 628.5 632.3 632.4 632.7 11825.6 12084.9 12095.6 12108.6 12152.5 12264.3 12783.4 12995.6 13086.9 13211.9 10002.6 10080.7 10101.2 10220.4 10230.4 3262.0 3270.1 3316.9 3389.3 3408.6 47535.0 47645.8 47688.3 47779.0 49050.3 10329.9 10440.3 10492.8 10497.5 10587.7 17504.0 17916.5 17916.8 17930.9 17951.6 6732.2 6768.7 6822.7 6895.0 6905.4 3879.7 3959.0 3978.3 3992.6 4009.7 2741.8 2766.2 2780.0 2785.2 2789.2 502.4 502.7 506.9 517.0 517.4 446.7 537.5 548.6 551.9 566.5 7266.6 7379.2 7449.3 7588.7 7660.4 493.7 561.5 575.0 611.4 625.1 3497.0 3612.7 3651.4 3664.4 3702.8 55964.4 56646.7 57400.7 57525.0 57594.7 48520.0 48840.0 49066.3 49145.5 49195.3 43469.0 44656.6 44703.3 44755.0 44975.8 7032.4 7101.0 7135.4 7173.1 7245.6 35134.6 35220.5 35232.3 36322.1 36323.8 40414.4 41258.0 42311.0 45059.5 45242.1 10494.7 10507.7 10646.9 10651.0 10705.4 10917.2 11119.9 11183.8 11568.2 11655.8 10891.2 11084.4 11150.6 11182.9 11276.5 11558.3 11880.0 11971.8 12071.3 12275.0 11091.0 11372.0 11535.1 11692.8 11721.8 9229.9 9356.3 9545.4 9641.8 9681.1 8666.4 9291.6 9595.6 9675.5 9682.4 11:57:05 INFO - PROCESS | 21898 | -------- Summary: end -------- 11:57:05 INFO - PROCESS | 21898 | 11:57:05 INFO - TEST-INFO | 21898: exit 0 11:57:05 INFO - TEST-OK | dromaeo_css | took 1117625ms 11:57:05 INFO - TEST-START | kraken 11:57:05 INFO - operating with platform_type : linux_ 11:57:05 INFO - Initialising browser for kraken test... 11:57:05 INFO - TEST-INFO | started process 22077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLpoJRB/profile http://localhost:59526/getInfo.html) 11:57:10 INFO - PROCESS | 22077 | __metrics Screen width/height:1600/1200 11:57:10 INFO - PROCESS | 22077 | colorDepth:24 11:57:10 INFO - PROCESS | 22077 | Browser inner width/height: 1024/697 11:57:10 INFO - PROCESS | 22077 | __metrics 11:57:11 ERROR - PROCESS | 22077 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:57:12 INFO - TEST-INFO | 22077: exit 0 11:57:12 INFO - Browser initialized. 11:57:12 INFO - Running cycle 1/1 for kraken test... 11:57:12 INFO - TEST-INFO | started process 22158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLpoJRB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:24 INFO - PROCESS | 22158 | RSS: Main: 153862144 11:57:24 INFO - PROCESS | 22158 | 11:57:26 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59526/tests/kraken/driver.html?testName=audio-beat-detection) 11:57:27 INFO - PROCESS | 22158 | RSS: Main: 195125248 11:57:27 INFO - PROCESS | 22158 | 11:57:29 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59526/tests/kraken/driver.html?testName=audio-dft) 11:57:30 INFO - PROCESS | 22158 | RSS: Main: 184541184 11:57:30 INFO - PROCESS | 22158 | 11:57:36 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59526/tests/kraken/driver.html?testName=audio-fft) 11:57:36 INFO - PROCESS | 22158 | RSS: Main: 173412352 11:57:36 INFO - PROCESS | 22158 | 11:57:38 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59526/tests/kraken/driver.html?testName=audio-oscillator) 11:57:39 INFO - PROCESS | 22158 | RSS: Main: 175939584 11:57:39 INFO - PROCESS | 22158 | 11:57:41 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59526/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:57:42 INFO - PROCESS | 22158 | RSS: Main: 175353856 11:57:42 INFO - PROCESS | 22158 | 11:57:45 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59526/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:45 INFO - PROCESS | 22158 | RSS: Main: 174678016 11:57:45 INFO - PROCESS | 22158 | 11:57:49 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59526/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:50 INFO - PROCESS | 22158 | RSS: Main: 172904448 11:57:50 INFO - PROCESS | 22158 | 11:57:53 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59526/tests/kraken/driver.html?testName=json-parse-financial) 11:57:53 INFO - PROCESS | 22158 | RSS: Main: 173400064 11:57:53 INFO - PROCESS | 22158 | 11:57:55 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59526/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:56 INFO - PROCESS | 22158 | RSS: Main: 187383808 11:57:56 INFO - PROCESS | 22158 | 11:57:58 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59526/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:58 INFO - PROCESS | 22158 | RSS: Main: 186363904 11:57:58 INFO - PROCESS | 22158 | 11:58:00 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59526/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:58:01 INFO - PROCESS | 22158 | RSS: Main: 193757184 11:58:01 INFO - PROCESS | 22158 | 11:58:03 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:58:04 INFO - PROCESS | 22158 | RSS: Main: 199053312 11:58:04 INFO - PROCESS | 22158 | 11:58:06 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:58:07 INFO - PROCESS | 22158 | RSS: Main: 196984832 11:58:07 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | Cycle 1(1): loaded http://localhost:59526/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59526/tests/kraken/driver.html?testName=ai-astar) 11:58:09 INFO - PROCESS | 22158 | RSS: Main: 259141632 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | __start_tp_report 11:58:09 INFO - PROCESS | 22158 | _x_x_mozilla_page_load 11:58:09 INFO - PROCESS | 22158 | _x_x_mozilla_page_load_details 11:58:09 INFO - PROCESS | 22158 | |i|pagename|runs| 11:58:09 INFO - PROCESS | 22158 | |0;ai-astar;113;112;106;112;113;112;102;113;114;112 11:58:09 INFO - PROCESS | 22158 | |1;audio-beat-detection;151;136;149;171;133;152;160;138;175;135 11:58:09 INFO - PROCESS | 22158 | |2;audio-dft;385;383;381;385;384;383;382;383;383;382 11:58:09 INFO - PROCESS | 22158 | |3;audio-fft;75;76;75;157;75;72;74;76;154;80 11:58:09 INFO - PROCESS | 22158 | |4;audio-oscillator;93;93;142;93;94;93;141;94;94;128 11:58:09 INFO - PROCESS | 22158 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;116;117;118 11:58:09 INFO - PROCESS | 22158 | |6;imaging-darkroom;193;194;193;193;195;194;193;193;194;193 11:58:09 INFO - PROCESS | 22158 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;96 11:58:09 INFO - PROCESS | 22158 | |8;json-parse-financial;65;65;66;65;65;66;68;66;66;65 11:58:09 INFO - PROCESS | 22158 | |9;json-stringify-tinderbox;65;64;64;64;64;64;63;64;64;63 11:58:09 INFO - PROCESS | 22158 | |10;stanford-crypto-aes;81;82;82;81;81;82;83;83;101;83 11:58:09 INFO - PROCESS | 22158 | |11;stanford-crypto-ccm;121;123;124;128;111;119;116;119;115;115 11:58:09 INFO - PROCESS | 22158 | |12;stanford-crypto-pbkdf2;145;129;138;140;140;129;139;137;136;138 11:58:09 INFO - PROCESS | 22158 | |13;stanford-crypto-sha256-iterative;66;66;65;65;65;66;65;67;67;67 11:58:09 INFO - PROCESS | 22158 | __end_tp_report 11:58:09 INFO - PROCESS | 22158 | __start_cc_report 11:58:09 INFO - PROCESS | 22158 | _x_x_mozilla_cycle_collect,1120 11:58:09 INFO - PROCESS | 22158 | __end_cc_report 11:58:09 INFO - PROCESS | 22158 | __startTimestamp1457981889501__endTimestamp 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | ------- Summary: start ------- 11:58:09 INFO - PROCESS | 22158 | Number of tests: 14 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.81 (3.4%) stddev-sans-first:3.97 11:58:09 INFO - PROCESS | 22158 | Values: 113.0 112.0 106.0 112.0 113.0 112.0 102.0 113.0 114.0 112.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:151.50 stddev:15.00 (9.9%) stddev-sans-first:15.91 11:58:09 INFO - PROCESS | 22158 | Values: 151.0 136.0 149.0 171.0 133.0 152.0 160.0 138.0 175.0 135.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#2] audio-dft Cycles:10 Average:383.10 Median:383.00 stddev:1.29 (0.3%) stddev-sans-first:1.17 11:58:09 INFO - PROCESS | 22158 | Values: 385.0 383.0 381.0 385.0 384.0 383.0 382.0 383.0 383.0 382.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.00 stddev:33.85 (45.1%) stddev-sans-first:35.38 11:58:09 INFO - PROCESS | 22158 | Values: 75.0 76.0 75.0 157.0 75.0 72.0 74.0 76.0 154.0 80.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.37 (23.0%) stddev-sans-first:22.10 11:58:09 INFO - PROCESS | 22158 | Values: 93.0 93.0 142.0 93.0 94.0 93.0 141.0 94.0 94.0 128.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:58:09 INFO - PROCESS | 22158 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 116.0 117.0 118.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#6] imaging-darkroom Cycles:10 Average:193.50 Median:193.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 11:58:09 INFO - PROCESS | 22158 | Values: 193.0 194.0 193.0 193.0 195.0 194.0 193.0 193.0 194.0 193.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:58:09 INFO - PROCESS | 22158 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 11:58:09 INFO - PROCESS | 22158 | Values: 65.0 65.0 66.0 65.0 65.0 66.0 68.0 66.0 66.0 65.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 11:58:09 INFO - PROCESS | 22158 | Values: 65.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 63.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:82.00 stddev:6.06 (7.4%) stddev-sans-first:6.34 11:58:09 INFO - PROCESS | 22158 | Values: 81.0 82.0 82.0 81.0 81.0 82.0 83.0 83.0 101.0 83.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:120.00 stddev:5.07 (4.2%) stddev-sans-first:5.33 11:58:09 INFO - PROCESS | 22158 | Values: 121.0 123.0 124.0 128.0 111.0 119.0 116.0 119.0 115.0 115.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:138.50 stddev:4.91 (3.5%) stddev-sans-first:4.29 11:58:09 INFO - PROCESS | 22158 | Values: 145.0 129.0 138.0 140.0 140.0 129.0 139.0 137.0 136.0 138.0 11:58:09 INFO - PROCESS | 22158 | 11:58:09 INFO - PROCESS | 22158 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 11:58:09 INFO - PROCESS | 22158 | Values: 66.0 66.0 65.0 65.0 65.0 66.0 65.0 67.0 67.0 67.0 11:58:09 INFO - PROCESS | 22158 | -------- Summary: end -------- 11:58:09 INFO - PROCESS | 22158 | 11:58:10 INFO - TEST-INFO | 22158: exit 0 11:58:10 INFO - TEST-OK | kraken | took 64578ms 11:58:10 INFO - SUITE-END | took 1182s 11:58:10 INFO - Completed test suite (00:19:42) 11:58:10 INFO - javascript benchmark 11:58:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2566.6406703061575, 2670.7996900232474, 2678.5848193529987, 2681.9061332853353, 2702.621632971384, 4551.431071116111, 4580.08398320336, 4598.287265473853, 4617.099665565216, 4669.0428462165255, 4630.606398456135, 4654.255319148937, 4655.4180727409075, 4720.480747117815, 4729.574338309551, 4198.6011328923705, 4204.411382406465, 4227.196832601811, 4258.850940217093, 4358.1283743251315, 4264.253755592759, 4295.033617436083, 4313.2451820931365, 4315.50371707253, 4363.258246098155, 4154.896127596804, 4157.688173386978, 4223.155368926196, 4226.619604235633, 4231.682623803227, 4235.004773878136, 4245.702800803945, 4247.0, 4273.102648443831, 4297.957020429787, 4191.3293872980485, 4224.683148763825, 4239.385289133089, 4256.787160641956, 4279.40088387626, 4425.491068527129, 4499.527549607277, 4533.093381323749, 4568.794404251817, 4574.222382195035, 4857.562819346241, 4900.0, 4900.142475066885, 4948.554630083274, 4972.925406118911, 4935.2843837643695, 4938.407391113054, 4941.530554597308, 4946.826861059882, 4947.975260123676, 4543.568361005732, 4576.725396476222, 4630.32860235264, 4670.299455081697, 4674.462436819741, 5051.040302342543, 5052.292679024939, 5068.721220332844, 5080.847574572768, 5123.948760512347, 4863.708177509361, 4868.9756551217015, 4871.732054737024, 4876.609871210295, 4921.532454416824, 4851.878703032452, 4902.90194196114, 4936.062148191904, 4981.0, 4981.277714731344, 4882.340883980688, 4902.754862256873, 4903.681260718042, 4914.557689807934, 4947.431045429749, 4781.976090119527, 4895.485973972753, 4897.534734200245, 4908.190148625508, 4946.579540739005, 4124.401961715595, 4128.60778226068, 4172.186423647359, 4175.874723758231, 4182.079942412725, 3627.05696518907, 3629.8366573504254, 3632.2553876455263, 3649.543807024122, 3676.3198808220563, 4281.464816897887, 4282.143571285693, 4282.807273672693, 4289.399484072233, 4323.935140972888, 4841.636877234221, 4870.318155458239, 4887.29134275528, 4906.362172917497, 4926.211806111077, 4271.615554600039, 4273.059926816096, 4275.893102672458, 4277.721948073366, 4319.244132276839, 4362.0839623679385, 4387.232234358974, 4400.251957167289, 4455.220336441174, 4472.619827314649, 4699.882502937454, 4727.479977202436, 4731.053789242234, 4765.237561990065, 4773.212419950669, 4944.184209605519, 4965.4041515018425, 4967.925481117713, 4974.477679843564, 5008.474110218374, 4624.583787459145, 4626.722396656077, 4726.172919738963, 4729.935764452971, 4774.594159496482, 4830.275458681226, 4843.515648435128, 4845.248986407112, 4869.683470574401, 4890.0, 4905.852824415273, 4907.386576677915, 4908.484609115992, 4923.458419573915, 4971.577415919687, 4709.576138147583, 4788.042391521779, 4788.186008378514, 4839.782209800638, 4854.83008094715, 4762.880927976828, 4772.0694464580465, 4777.0, 4814.037192561572, 4830.903381932412, 4719.268513380294, 4723.976380118077, 4726.078414709099, 4753.667243292936, 4766.571008609242, 4747.667663263538, 4759.190937540558, 4786.617070634411, 4799.160146974195, 4822.662413631012, 4693.131770622445, 4723.4331880174595, 4723.976380118077, 4725.645576581839, 4751.83368582098], "unit": "score", "name": "dojo.html", "value": 4534.274772303851}, {"lowerIsBetter": false, "replicates": [530.6948504609849, 531.7367902888069, 548.8847342058168, 551.8316913341432, 553.4797290546888, 27255.454890902194, 34239.0, 35536.822315888414, 35569.46645800309, 35583.288334233366, 38262.42606360907, 38923.221535569275, 38937.22125557494, 38963.22073558527, 38978.41532377017, 7594.354479869217, 7768.339691126261, 7773.533587984711, 7774.222577742237, 7777.10563285221, 7579.279968402993, 7693.8076548086465, 7696.846063078735, 7700.306972372486, 7882.881756773624, 7837.216278372174, 7905.881411778799, 7905.920940790576, 7907.683692652287, 7909.96045019777, 7778.5721785301785, 7837.294643482057, 7877.881831772528, 7884.093329267093, 7889.092754333267, 7714.4214183935865, 7873.8031549211155, 7874.173211812735, 7875.0, 7876.527408355517, 38349.80825095884, 38775.80612096949, 38789.61210387917, 38810.80594597009, 38812.0, 3247.7401807855313, 3295.8516866741056, 3532.364174448598, 3714.851405943759, 3806.4290356446477, 29656.40687186244, 30201.09396718102, 30360.0, 30615.38769224603, 30832.38335233283, 3292.0, 3330.4837750148768, 3338.549295845054, 3349.7822641528223, 3385.0691059958463, 255642.0, 292115.0, 296442.0, 296527.0, 297399.66902151506, 53609.0, 54028.45971540313, 54106.0, 54115.91768164615, 54300.0, 58007.419925800205, 64569.35430645727, 66120.33879661238, 66124.6693766528, 66146.66926665336, 15136.394544218108, 15405.691886162214, 15419.460318888785, 15423.614409639624, 15429.30568124437, 11671.88328116708, 11838.230515016496, 11845.0, 11847.111466640037, 11847.170698051226, 19573.21707131727, 19928.60142797136, 20551.280705175246, 20734.170633174504, 20779.792202077784, 7793.0, 7985.560794156378, 7999.9600001999615, 8090.635921383552, 8099.595020249082, 877.8770972063916, 884.3897710579679, 903.746950853762, 923.3351986569659, 949.7055912667096, 26675.733242667713, 27692.0, 29377.0, 31044.53433198504, 31262.0, 972.7665360313474, 988.2736188901152, 994.6170724271063, 1037.0459177556666, 1037.1702637889657, 13706.65733356674, 14043.368048437846, 14255.572332830032, 14289.714205716036, 14298.714025719428, 373875.0, 375379.0, 380124.0, 380183.0, 380349.0, 48480.75759621179, 48794.75602621964, 49329.0, 49442.75278623584, 49443.0, 1203.2239205712267, 1215.2283300104498, 1233.2477188914754, 1272.1603741530546, 1274.8852603265566, 25819.354516136496, 27634.447311054068, 27660.0, 27812.44375112527, 28146.71853281523, 38366.42450363191, 38732.0, 38732.41901371538, 38787.0, 39203.21593568056, 204354.0, 204624.0, 205533.0, 206022.0, 206026.0, 26089.478210436064, 30513.38973220479, 30552.84723576368, 30571.23571910631, 30588.847055764578, 33615.66384336125, 34277.82861085778, 34692.0, 34724.47913281252, 34778.30443391169, 30154.24614384658, 30256.0, 30586.694133059274, 30790.846045769627, 30996.69003309938, 29999.400012000075, 30452.543211852284, 30674.233144171576, 30724.231894202825, 33204.50193247055, 32549.674503254664, 32652.83673581617, 33189.668103318654, 33223.501647475794, 33232.33535329328, 29369.265768355963, 29697.70302297036, 29706.702932971257, 29740.256493587833, 29778.702212977594, 23109.653355200022, 23335.0, 23348.76651233466, 23582.0, 23582.0], "unit": "score", "name": "ext.html", "value": 17272.7475155663}, {"lowerIsBetter": false, "replicates": [354.1624059100227, 359.14702581369244, 362.2085742652304, 367.40480421716825, 370.4313878196968, 15635.609109772262, 15906.840931590696, 16343.509694709148, 16759.329626814913, 16824.158792060378, 15974.201289935514, 16105.919470402632, 16649.1675416229, 16650.75023874643, 16665.33338666452, 4860.416749990006, 4919.557239848404, 4991.425986011601, 4995.900081998358, 5049.621278404116, 4937.753112344386, 5006.724630145341, 5011.473795251501, 5018.523240292185, 5038.445770965191, 4918.754062296871, 4962.0, 4964.304997300381, 4977.228529577921, 5000.749962501878, 4879.316895634614, 4980.477049909761, 5003.8991421887495, 5021.17150670139, 5029.270755740416, 4468.151051300275, 4481.35020422037, 4493.977530112328, 4510.548945105464, 4512.210363186462, 18331.45005649833, 19367.51581210467, 19588.70616940747, 19628.313009044614, 19630.214791408325, 1929.8552608554273, 1945.873518221311, 1982.821546060847, 2095.738032745907, 2404.603240465321, 12425.378731063502, 12488.12583119182, 12598.0, 12641.367931603383, 12729.172603780817, 1728.08411541883, 1769.3453422233856, 1784.8661350398772, 1792.2741289777662, 1793.7040388335909, 56679.0, 58523.707381463246, 61202.38797612012, 62747.0, 65359.3464065358, 9860.16188623975, 10049.69850904474, 10139.138173255209, 10143.949280253699, 10282.07461328484, 12911.096223264281, 13021.739565208833, 13034.348282585834, 13041.478340866448, 13074.346282685829, 7431.777046688608, 7489.400847932152, 7557.206493318123, 7584.962075189699, 7653.846923061507, 7280.854382912418, 7364.374028207555, 7463.141738700119, 7473.4021278297605, 7479.401647868266, 4306.0526684129445, 4340.76125813077, 4367.973526221335, 4415.094905544356, 4417.823287068545, 1743.9825601744074, 1759.3314540474537, 1766.1522469214592, 1787.9821201788077, 1798.7751531058618, 859.110820300998, 871.0542726201871, 887.8357503861806, 920.8710780490736, 958.3195930889008, 15696.92151539235, 15755.212239387985, 15864.286107125206, 16072.758908616146, 16168.27242774078, 845.5287799229296, 862.2369203255164, 873.8776571280026, 886.7118186589385, 915.8443064678887, 8928.508932008672, 9038.322125840588, 9140.0, 9316.301277404222, 9429.76425589352, 401658.0, 421272.0, 426688.0, 433178.0, 438221.0, 65249.34750652528, 67431.0, 67663.27851968189, 69232.30767692359, 69571.65214173897, 963.7638778499313, 964.6864768949979, 964.9372790768577, 965.9758506037265, 968.5205823117602, 13774.65563360924, 13873.4450621974, 14124.223167725873, 14173.574792756233, 14315.928420357832, 32700.83649581737, 33547.83226083854, 33696.15759606029, 33737.0, 33871.83064084664, 45044.54955450403, 45814.77092614515, 45936.54063459457, 45955.0, 46224.07551849011, 7416.4066874648815, 7425.517341372793, 7451.3293803557945, 7563.546187228784, 7573.35626471756, 8821.691240806542, 11174.72063198394, 11202.775944481227, 11233.101351891992, 11276.097912167172, 9222.723318300461, 9454.858177127486, 9516.286278529, 9540.427574345562, 9572.329936904629, 9149.0, 9830.557624906753, 9843.261755368232, 9932.354396964174, 9995.750106247111, 9526.285528585246, 9560.378575392577, 9654.131128198496, 9744.951275243578, 9871.901280987098, 7299.671514781741, 7385.076865391826, 7397.926020739724, 7421.406287497095, 7498.58757768328, 8145.51126932386, 8892.199702026848, 9684.757881052748, 9764.511774411392, 10051.447170405405], "unit": "score", "name": "jquery.html", "value": 7970.065833412836}, {"lowerIsBetter": false, "replicates": [1309.9476020959162, 1418.531884478122, 1436.4613270023738, 1606.148741167181, 1806.801251862295, 6928.099347084878, 7121.572705637665, 7149.106361704787, 7161.140663120426, 7173.928260717391, 7019.859602807941, 7217.81955451114, 7223.205447400795, 7225.349718525332, 7233.927660723404, 1914.731937528747, 2161.9891900540474, 2182.0835249195297, 2208.900599473028, 2237.451824303048, 2239.0819763896807, 2243.753187149412, 2250.9212177573786, 2252.7409347924954, 2253.256425379629, 2147.4846036951176, 2234.106357457022, 2234.625705191304, 2236.0720301075035, 2236.586231547161, 2194.1662168376074, 2195.078067211775, 2208.7349518057854, 2248.9662655060188, 2258.0516183203094, 2189.8905054747197, 2219.4895174110047, 2222.466608014081, 2223.7331520217676, 2244.943876403103, 7302.853942921111, 7369.668364923591, 7371.483996120273, 7373.77878663641, 7385.335319821188, 4531.252343363341, 4621.168189725848, 4648.721076735406, 4658.650601204923, 4664.5335466453425, 2915.489789286866, 2929.8095623784384, 2975.851207439641, 2978.6723460419335, 3066.6779988101152, 899.0649724286799, 903.814717982812, 915.2860768600435, 924.7919218175924, 941.637469574212, 10002.399856008662, 10056.648017319432, 10082.848757268646, 10087.899121008842, 10092.0, 4150.833966641361, 4240.766757828349, 4309.827606895752, 4332.133573285356, 4334.631556317749, 8590.484570925764, 8656.697015604424, 8678.132186781271, 8683.435576687496, 8691.261242794433, 4058.188362327546, 4520.50274469808, 4525.502194758574, 4532.773361331986, 4535.9773201133785, 3729.030452082478, 3765.8870233893026, 4073.368627862686, 4170.895727606834, 4184.853530126492, 3688.3176612326806, 3706.129059670975, 3759.266942946154, 3782.905427364283, 3786.753860999026, 1196.5692350753723, 1197.22180582622, 1207.124834494984, 1209.9697507562382, 1230.341767154568, 1017.893121222261, 1029.2743615750878, 1184.0527577937617, 1184.1888306510068, 1209.2804781155198, 6761.932380676229, 6804.9319506804295, 6827.897581536281, 6859.519833611699, 6879.140107486564, 473.27116240988494, 479.37681014680777, 481.41267653462717, 485.6915858429852, 486.4940461919635, 5012.198048312325, 5050.292958985745, 5054.444011158843, 5070.442251352349, 5089.414717307557, 8231.670733170726, 8320.37597180214, 8448.83102337962, 8799.780005499913, 8834.381593288408, 8645.610947507377, 8688.435251708619, 8689.0, 8750.781230469289, 8763.430377025474, 6664.700088496029, 6801.795946121624, 6851.9657401712675, 6883.105196324445, 6884.311568843075, 6356.300806911328, 6382.96808515973, 6403.231612206565, 6423.743050277936, 6431.324710905287, 7629.542227466148, 7698.730544430918, 7707.306342429209, 7722.073351197892, 7732.110807257012, 7600.859871019391, 7903.012123484565, 8007.639656215368, 8009.519428834055, 8014.519128852287, 5599.552035837205, 5731.942680573141, 5740.885182296247, 6188.1027251049245, 6251.437370636664, 6064.272287325549, 6895.172579290517, 6911.481638877004, 6922.757703480354, 6938.375546200866, 6207.131001659681, 6219.0982307566055, 6304.464120549805, 6339.524535659752, 6354.841128971812, 6019.337872834072, 6165.10605962124, 6169.81490555284, 6253.062040693932, 6261.906071409024, 6336.081268216175, 6394.968025159845, 6404.615723056631, 6522.380373864476, 6560.048792924904, 6152.600080994721, 6183.3816618337805, 6196.752129914753, 6199.442050215503, 6200.379962003944, 5925.1704761332585, 6065.363136870565, 6065.423784740443, 6071.969640151948, 6086.817395478142], "unit": "score", "name": "mootools.html", "value": 4134.172393814258}, {"lowerIsBetter": false, "replicates": [320.2170692656456, 320.67932067932065, 325.2632786738037, 327.4907518808253, 328.51543972640343, 5362.946370536293, 5389.299391079159, 5392.056390131731, 5437.293151890259, 5459.535939445152, 5332.0, 5339.038972984861, 5344.812931547397, 5348.117560602496, 5369.9463005369935, 3983.760974341534, 4099.938500922489, 4183.832646694136, 4191.832326706928, 4230.302000169968, 4192.161567686459, 4210.768407737573, 4216.51510076342, 4221.725587836796, 4227.640650544692, 4187.204431158086, 4190.371444283352, 4191.266528357541, 4191.517975432834, 4204.621584057434, 3928.764274143546, 4046.494188226457, 4162.666986641092, 4193.874183774492, 4204.369344598304, 3715.5727091384565, 3718.8698395556025, 3723.553173619183, 3727.683146932514, 3734.458503517002, 5135.948640513584, 5158.019976204547, 5163.793448262065, 5164.302819119408, 5167.48325167484, 4848.29699693546, 4864.318995340655, 4865.6107511399005, 4867.099586576459, 4869.172240719086, 5658.7170641467765, 5665.036943719578, 5674.687892165929, 5676.460736230051, 5680.261565996435, 3989.0101730155425, 4089.5297040840087, 4098.4876890388705, 4102.50769907613, 4110.034141976633, 5858.677772722499, 5933.673647949361, 5934.198883150762, 5943.4056594340655, 5955.642661440327, 4184.727992680466, 4206.896551724138, 4208.726432781859, 4210.157968406331, 4210.347396153601, 4253.404523366731, 4269.23153832307, 4271.0, 4274.465691788527, 4275.572442755762, 4808.471068182497, 4828.179209534387, 4829.66192366531, 4831.154547954094, 4838.782254798542, 5660.037793575102, 5669.688167150764, 5670.404607516151, 5676.68778217202, 5680.573956953245, 1390.6870954035262, 1467.031759039029, 1493.8132733408324, 1495.5812372535706, 1497.6779992301708, 864.429476545477, 951.2485136741897, 953.7520244736419, 972.2367941166151, 983.1593987140892, 4981.427135879348, 4998.725070121105, 5000.299958005882, 5009.874753131201, 5011.298418221452, 5836.066229403275, 5893.263342082239, 5898.115282707542, 5898.144769008555, 5899.203607513016, 4965.453800081988, 4994.40067191932, 4997.600191984632, 5006.6495345325475, 5007.624428167902, 3088.6911308869385, 3122.9063128106195, 3124.328269422085, 3126.906192814219, 3130.092273240735, 5466.726663666801, 5477.370102438191, 5500.50495455411, 5505.862353441196, 5515.25544051556, 5816.272965879265, 5991.4907232884825, 6088.939110608926, 6093.11649810775, 6101.664408457577, 5584.9388616163615, 5595.63628364155, 5601.579881508822, 5619.8876022480135, 5620.775168993195, 5914.556408269311, 5918.112283157561, 5926.762929482772, 5932.525397968238, 5938.584299099021, 5787.681677507778, 5791.507721843691, 5798.275215598051, 5799.159121927381, 5806.622569532967, 5376.650517716336, 5581.190727344431, 5589.664620122806, 5596.076647353141, 5597.776088956396, 3959.5248570171766, 3969.8412063517135, 3971.0667993022194, 3983.203359328088, 3986.1031267965636, 5891.05743081105, 5892.351841297368, 5897.941020589739, 5898.734556945034, 5903.409659034234, 5688.175214593778, 5701.686407247641, 5701.857453563694, 5702.5437964961875, 5705.429457054262, 5696.658200507983, 5699.857503562444, 5701.657900525982, 5705.144228365778, 5708.229389032427, 5368.087425137658, 5553.611247212656, 5598.692071936082, 5604.495595396434, 5608.990381731328, 5645.576581756302, 5668.2064510967675, 5675.460831221028, 5679.17651940458, 5681.545476361964, 5508.7521061553125, 5607.383187849252, 5614.606977511535, 5615.691136987505, 5616.382197958303], "unit": "score", "name": "prototype.html", "value": 4278.974598139432}, {"lowerIsBetter": false, "replicates": [622.5953130465199, 721.1346384338789, 769.5267410542516, 777.8094366880111, 785.2932360875216, 11459.770804583903, 11658.125640576949, 11668.41657917104, 11679.474423650934, 11682.0070294025, 10970.780584388307, 10991.230613857033, 11015.614453494129, 11097.83353249702, 11114.777704445927, 780.8906753054563, 799.4963173200904, 803.4978138663336, 804.3645520039162, 804.9074356449024, 641.1344684675697, 791.0665414810521, 808.3937047214589, 812.6424373275739, 815.8613035783931, 850.7617866997251, 855.3969451536683, 856.867185586232, 857.2670366836359, 857.3526987124712, 673.3300366135677, 844.1895780051158, 851.4720873058712, 851.5954921412341, 852.2074470742207, 621.4531212532942, 628.4909223528956, 632.250782822357, 632.3802673380113, 632.686820024091, 11825.586104486387, 12084.879151208463, 12095.576654817127, 12108.57619983305, 12152.513899444011, 12264.325462099581, 12783.360831958365, 12995.610131696065, 13086.937927056082, 13211.867881321159, 10002.649907253284, 10080.69757907264, 10101.19190464761, 10220.437875916821, 10230.386176829414, 3261.983690081558, 3270.051685011344, 3316.9004929851903, 3389.3390788796196, 3408.590969083701, 47535.0, 47645.76177119127, 47688.28467572989, 47779.0, 49050.26424603598, 10329.948350258352, 10440.269181157399, 10492.842607360895, 10497.527611257512, 10587.735306617242, 17504.037277949836, 17916.462506124837, 17916.820831791774, 17930.91034544819, 17951.640967180585, 6732.192136943598, 6768.7292508299115, 6822.692978815965, 6895.034695142684, 6905.447564194852, 3879.7478163919254, 3959.0, 3978.2839088964265, 3992.5807790182193, 4009.69927255457, 2741.849198294073, 2766.1839757271655, 2780.0, 2785.220138361262, 2789.246903336088, 502.36200025966815, 502.7285265956416, 506.8910184310391, 517.0021857814454, 517.3533083645443, 446.74312270444625, 537.5028099008401, 548.569373042168, 551.8730691940796, 566.487328967277, 7266.600336981517, 7379.2251813558805, 7449.329560339487, 7588.696452141963, 7660.387169026464, 493.6593750312273, 561.5227057001516, 575.0368133376578, 611.400827189357, 625.0780099353417, 3497.0, 3612.674859262679, 3651.415773476231, 3664.3770559005034, 3702.777833330009, 55964.44035559674, 56646.71676641673, 57400.712996435585, 57525.0, 57594.7120264396, 48520.0, 48840.0, 49066.264006039935, 49145.50854491409, 49195.262071068966, 43469.0, 44656.55343446589, 44703.32945005828, 44755.0, 44975.775121124185, 7032.437405007485, 7101.0, 7135.429165666838, 7173.10336207974, 7245.637718113968, 35134.64865351314, 35220.47169292514, 35232.29535409329, 36322.091947700465, 36323.81838090793, 40414.393784092674, 41258.0, 42311.0, 45059.54940450554, 45242.09515809731, 10494.68515944523, 10507.684769456928, 10646.89353106459, 10651.0, 10705.411202383631, 10917.181211409017, 11119.944400277947, 11183.832242516206, 11568.24806387582, 11655.76688466243, 10891.18316126278, 11084.390358530358, 11150.553977840795, 11182.944085279521, 11276.548938042386, 11558.30650160993, 11880.0, 11971.760564788481, 12071.275723456269, 12275.0, 11091.0, 11372.033377162703, 11535.134864885, 11692.766144677229, 11721.824172637247, 9229.907700922904, 9356.251499879858, 9545.379550329206, 9641.758956025875, 9681.128698416895, 8666.393352465268, 9291.581878815334, 9595.616175352907, 9675.467849268358, 9682.361454200494], "unit": "score", "name": "yui.html", "value": 5965.648586833684}], "name": "dromaeo_css", "value": 6355.167107110215}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 106.0, 112.0, 113.0, 112.0, 102.0, 113.0, 114.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [151.0, 136.0, 149.0, 171.0, 133.0, 152.0, 160.0, 138.0, 175.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 150.0}, {"lowerIsBetter": true, "replicates": [385.0, 383.0, 381.0, 385.0, 384.0, 383.0, 382.0, 383.0, 383.0, 382.0], "unit": "score", "name": "audio-dft", "value": 383.1}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 75.0, 157.0, 75.0, 72.0, 74.0, 76.0, 154.0, 80.0], "unit": "score", "name": "audio-fft", "value": 91.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 142.0, 93.0, 94.0, 93.0, 141.0, 94.0, 94.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 116.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [193.0, 194.0, 193.0, 193.0, 195.0, 194.0, 193.0, 193.0, 194.0, 193.0], "unit": "score", "name": "imaging-darkroom", "value": 193.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 68.0, 66.0, 66.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 65.7}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 81.0, 81.0, 82.0, 83.0, 83.0, 101.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 124.0, 128.0, 111.0, 119.0, 116.0, 119.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [145.0, 129.0, 138.0, 140.0, 140.0, 129.0, 139.0, 137.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1783.4}]} 11:58:10 INFO - Return code: 0 11:58:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:58:10 ERROR - # TBPL SUCCESS # 11:58:10 INFO - Running post-action listener: _resource_record_post_action 11:58:10 INFO - Running post-run listener: _resource_record_post_run 11:58:11 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525123584; Read time: 12; Write time: 422012 11:58:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232103936; Read time: 0; Write time: 267660 11:58:11 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292421632; Read time: 12; Write time: 154352 11:58:11 INFO - Running post-run listener: _upload_blobber_files 11:58:11 INFO - Blob upload gear active. 11:58:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:58:11 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 11:58:11 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'] 11:58:11 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 11:58:12 INFO - (blobuploader) - INFO - Open directory for files ... 11:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:13 INFO - (blobuploader) - INFO - Done attempting. 11:58:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:58:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:13 INFO - (blobuploader) - INFO - Done attempting. 11:58:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:58:13 INFO - Return code: 0 11:58:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:58:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:58:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14220710c7422b800d2ee97b0ba9f89653394ae661d8e8443261a1491f00dc3e93af0a5c83ab44d53828adbd9a90136deac7fee1ce305b2fe7923381fd43e6dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b97bcb4f5749078033b3e3f80478f098d2a5c9323003bcf771c0fef08494e4a0852d69ba90cca666bc0c555b2d9e9ff510c7db95cd9c677a73e662668fde7e46"} 11:58:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:58:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:58:13 INFO - Contents: 11:58:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14220710c7422b800d2ee97b0ba9f89653394ae661d8e8443261a1491f00dc3e93af0a5c83ab44d53828adbd9a90136deac7fee1ce305b2fe7923381fd43e6dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b97bcb4f5749078033b3e3f80478f098d2a5c9323003bcf771c0fef08494e4a0852d69ba90cca666bc0c555b2d9e9ff510c7db95cd9c677a73e662668fde7e46"} 11:58:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:58:13 INFO - Copying logs to upload dir... 11:58:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:58:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.083876 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-14 11:58:13.541570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 11:58:13.545357) ========= 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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 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/14220710c7422b800d2ee97b0ba9f89653394ae661d8e8443261a1491f00dc3e93af0a5c83ab44d53828adbd9a90136deac7fee1ce305b2fe7923381fd43e6dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b97bcb4f5749078033b3e3f80478f098d2a5c9323003bcf771c0fef08494e4a0852d69ba90cca666bc0c555b2d9e9ff510c7db95cd9c677a73e662668fde7e46"} build_url:https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011527 build_url: 'https://queue.taskcluster.net/v1/task/I_2f1uyiQxuEtA3gxtz0DA/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/14220710c7422b800d2ee97b0ba9f89653394ae661d8e8443261a1491f00dc3e93af0a5c83ab44d53828adbd9a90136deac7fee1ce305b2fe7923381fd43e6dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b97bcb4f5749078033b3e3f80478f098d2a5c9323003bcf771c0fef08494e4a0852d69ba90cca666bc0c555b2d9e9ff510c7db95cd9c677a73e662668fde7e46"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 11:58:13.569978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:58:13.570299) ========= 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=d2a8c569965ab8367867b893000001a1-1457980653.878202-295749120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005084 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 11:58:13.655840) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 11:58:13.656161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 11:58:13.656460) ========= ========= Total master_lag: 0.27 =========