builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1457640332.2 results: success (0) buildid: 20160310104625 builduid: 6aefd1c0e5804bf382fbb178119666df revision: dd5aaa1e47adcf1506c854a89bb934bb288e6f79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.197179) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.197575) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.197903) ========= 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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006391 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.223800) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.224160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.248082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.248449) ========= 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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.306998) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.307498) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.307868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.308136) ========= 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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-10 12:05:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.2M=0s 2016-03-10 12:05:32 (96.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167860 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.489922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.490215) ========= 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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015695 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:32.539211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 12:05:32.539556) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd5aaa1e47adcf1506c854a89bb934bb288e6f79 --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 dd5aaa1e47adcf1506c854a89bb934bb288e6f79 --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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-10 12:05:32,730 truncating revision to first 12 chars 2016-03-10 12:05:32,730 Setting DEBUG logging. 2016-03-10 12:05:32,730 attempt 1/10 2016-03-10 12:05:32,730 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd5aaa1e47ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 12:05:34,206 unpacking tar archive at: fx-team-dd5aaa1e47ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.849515 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 12:05:34.401894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:34.402215) ========= echo dd5aaa1e47adcf1506c854a89bb934bb288e6f79 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dd5aaa1e47adcf1506c854a89bb934bb288e6f79'] 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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False dd5aaa1e47adcf1506c854a89bb934bb288e6f79 program finished with exit code 0 elapsedTime=0.003807 script_repo_revision: 'dd5aaa1e47adcf1506c854a89bb934bb288e6f79' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:34.450111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:34.450411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 12:05:34.460576) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-03-10 12:05:34.460950) ========= /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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:05:34 INFO - MultiFileLogger online at 20160310 12:05:34 in /builds/slave/test 12:05:34 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 12:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:05:34 INFO - {'append_to_log': False, 12:05:34 INFO - 'base_work_dir': '/builds/slave/test', 12:05:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:05:34 INFO - 'branch': 'Fx-Team-Non-PGO', 12:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 12:05:34 INFO - 'config_files': ('talos/linux_config.py',), 12:05:34 INFO - 'default_actions': ('clobber', 12:05:34 INFO - 'read-buildbot-config', 12:05:34 INFO - 'download-and-extract', 12:05:34 INFO - 'populate-webroot', 12:05:34 INFO - 'create-virtualenv', 12:05:34 INFO - 'install', 12:05:34 INFO - 'run-tests'), 12:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:05:34 INFO - 'download_minidump_stackwalk': True, 12:05:34 INFO - 'download_symbols': 'ondemand', 12:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 12:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 12:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:05:34 INFO - 'installer_path': 'installer.exe', 12:05:34 INFO - 'log_level': 'info', 12:05:34 INFO - 'log_name': 'talos', 12:05:34 INFO - 'log_to_console': True, 12:05:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:05:34 INFO - 'opt_config_files': (), 12:05:34 INFO - 'pip_index': False, 12:05:34 INFO - 'sps_profile': False, 12:05:34 INFO - 'sps_profile_interval': 0, 12:05:34 INFO - 'suite': 'dromaeojs', 12:05:34 INFO - 'system_bits': '32', 12:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:05:34 INFO - 'title': 'talos-linux64-ix-002', 12:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:05:34 INFO - 'use_talos_json': True, 12:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:05:34 INFO - 'work_dir': 'build'} 12:05:34 INFO - ##### 12:05:34 INFO - ##### Running clobber step. 12:05:34 INFO - ##### 12:05:34 INFO - Running pre-action listener: _resource_record_pre_action 12:05:34 INFO - Running main action method: clobber 12:05:34 INFO - rmtree: /builds/slave/test/build 12:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:05:35 INFO - Running post-action listener: _resource_record_post_action 12:05:35 INFO - ##### 12:05:35 INFO - ##### Running read-buildbot-config step. 12:05:35 INFO - ##### 12:05:35 INFO - Running pre-action listener: _resource_record_pre_action 12:05:35 INFO - Running main action method: read_buildbot_config 12:05:35 INFO - Using buildbot properties: 12:05:35 INFO - { 12:05:35 INFO - "project": "", 12:05:35 INFO - "product": "firefox", 12:05:35 INFO - "script_repo_revision": "production", 12:05:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:05:35 INFO - "repository": "", 12:05:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:05:35 INFO - "buildid": "20160310104625", 12:05:35 INFO - "pgo_build": "False", 12:05:35 INFO - "basedir": "/builds/slave/test", 12:05:35 INFO - "buildnumber": 2622, 12:05:35 INFO - "slavename": "talos-linux64-ix-002", 12:05:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:05:35 INFO - "platform": "ubuntu64_hw", 12:05:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:05:35 INFO - "branch": "fx-team", 12:05:35 INFO - "repo_path": "integration/fx-team", 12:05:35 INFO - "revision": "dd5aaa1e47adcf1506c854a89bb934bb288e6f79", 12:05:35 INFO - "stage_platform": "linux64", 12:05:35 INFO - "builduid": "6aefd1c0e5804bf382fbb178119666df", 12:05:35 INFO - "slavebuilddir": "test" 12:05:35 INFO - } 12:05:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:05:35 INFO - Running post-action listener: _resource_record_post_action 12:05:35 INFO - ##### 12:05:35 INFO - ##### Running download-and-extract step. 12:05:35 INFO - ##### 12:05:35 INFO - Running pre-action listener: _resource_record_pre_action 12:05:35 INFO - Running main action method: download_and_extract 12:05:35 INFO - mkdir: /builds/slave/test/build/tests 12:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:05:35 INFO - https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:40 INFO - Downloaded 1361 bytes. 12:05:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:05:40 INFO - Using the following test package requirements: 12:05:40 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:05:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:05:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:05:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:40 INFO - u'jsshell-linux-x86_64.zip'], 12:05:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:05:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:05:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:05:40 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:05:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:05:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:05:40 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:05:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:05: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')]} 12:05:40 INFO - https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:05:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:05:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:05:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:45 INFO - Downloaded 22093190 bytes. 12:05:45 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'] 12:05:45 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 12:05:46 INFO - Return code: 0 12:05:46 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 12:05:46 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')]} 12:05:46 INFO - https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:53 INFO - Downloaded 22093190 bytes. 12:05:53 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'] 12:05:53 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 12:05:54 INFO - Return code: 0 12:05:54 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')]} 12:05:54 INFO - https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:05:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:05:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:05:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:55 INFO - Downloaded 10845161 bytes. 12:05:55 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'] 12:05:55 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 12:05:56 INFO - Return code: 0 12:05:56 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')]} 12:05:56 INFO - https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:05:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:05:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:05:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4N3QfazRUOv1sDjPtrxgw/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 12:05:57 INFO - Downloaded 54425343 bytes. 12:05:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:05:57 INFO - mkdir: /builds/slave/test/properties 12:05:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:05:57 INFO - Writing to file /builds/slave/test/properties/build_url 12:05:57 INFO - Contents: 12:05:57 INFO - build_url:https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:05:58 INFO - Running post-action listener: _resource_record_post_action 12:05:58 INFO - Running post-action listener: set_extra_try_arguments 12:05:58 INFO - ##### 12:05:58 INFO - ##### Running populate-webroot step. 12:05:58 INFO - ##### 12:05:58 INFO - Running pre-action listener: _resource_record_pre_action 12:05:58 INFO - Running main action method: populate_webroot 12:05:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:05:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:05:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:05:58 INFO - '--tppagecycles', 12:05:58 INFO - '7'], 12:05:58 INFO - 'tests': ['tsvgm']}}, 12:05:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:05:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:05:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:05:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:05:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:58 INFO - 'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:05:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:58 INFO - 'tests': ['damp', 'tps']}, 12:05:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:58 INFO - 'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['damp', 'tps']}, 12:05:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:05:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:05:58 INFO - 'other': {'tests': ['a11yr', 12:05:58 INFO - 'ts_paint', 12:05:58 INFO - 'tpaint', 12:05:58 INFO - 'sessionrestore', 12:05:58 INFO - 'sessionrestore_no_auto_restore', 12:05:58 INFO - 'tabpaint']}, 12:05:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['a11yr', 12:05:58 INFO - 'ts_paint', 12:05:58 INFO - 'tpaint', 12:05:58 INFO - 'sessionrestore', 12:05:58 INFO - 'sessionrestore_no_auto_restore', 12:05:58 INFO - 'tabpaint']}, 12:05:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['a11yr', 12:05:58 INFO - 'ts_paint', 12:05:58 INFO - 'tpaint', 12:05:58 INFO - 'sessionrestore', 12:05:58 INFO - 'sessionrestore_no_auto_restore', 12:05:58 INFO - 'tabpaint']}, 12:05:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['a11yr', 12:05:58 INFO - 'ts_paint', 12:05:58 INFO - 'tpaint', 12:05:58 INFO - 'sessionrestore', 12:05:58 INFO - 'sessionrestore_no_auto_restore', 12:05:58 INFO - 'tabpaint']}, 12:05:58 INFO - 'other_l64': {'tests': ['a11yr', 12:05:58 INFO - 'ts_paint', 12:05:58 INFO - 'tpaint', 12:05:58 INFO - 'sessionrestore', 12:05:58 INFO - 'sessionrestore_no_auto_restore', 12:05:58 INFO - 'tabpaint']}, 12:05:58 INFO - 'other_nol64': {'tests': ['a11yr', 12:05:58 INFO - 'ts_paint', 12:05:58 INFO - 'tpaint', 12:05:58 INFO - 'sessionrestore', 12:05:58 INFO - 'sessionrestore_no_auto_restore', 12:05:58 INFO - 'tabpaint']}, 12:05:58 INFO - 'svgr': {'tests': ['tsvgx', 12:05:58 INFO - 'tsvgr_opacity', 12:05:58 INFO - 'tart', 12:05:58 INFO - 'tscrollx', 12:05:58 INFO - 'cart']}, 12:05:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['tsvgx', 12:05:58 INFO - 'tsvgr_opacity', 12:05:58 INFO - 'tart', 12:05:58 INFO - 'tscrollx', 12:05:58 INFO - 'cart']}, 12:05:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:58 INFO - 'tests': ['tp5o']}, 12:05:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:58 INFO - 'talos_options': ['--e10s'], 12:05:58 INFO - 'tests': ['tp5o']}, 12:05:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:58 INFO - 'talos_options': ['--xperf_path', 12:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:58 INFO - 'tests': ['tp5n']}, 12:05:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:05:58 INFO - 'talos_options': ['--e10s', 12:05:58 INFO - '--xperf_path', 12:05:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:05:58 INFO - 'tests': ['tp5n']}}, 12:05:58 INFO - 'talos.zip': {'path': '', 12:05:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:05:58 INFO - Running post-action listener: _resource_record_post_action 12:05:58 INFO - ##### 12:05:58 INFO - ##### Running create-virtualenv step. 12:05:58 INFO - ##### 12:05:58 INFO - Running pre-action listener: _resource_record_pre_action 12:05:58 INFO - Running main action method: create_virtualenv 12:05:58 INFO - Creating virtualenv /builds/slave/test/build/venv 12:05:58 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 12:05:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:05:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:05:58 INFO - Using real prefix '/usr' 12:05:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:05:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:06:00 INFO - Installing pip.................done. 12:06:00 INFO - Return code: 0 12:06:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:06:00 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')]} 12:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:00 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')]} 12:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:00 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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06:00 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 12:06:00 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 12:06:00 INFO - Using env: {'DISPLAY': ':0', 12:06:00 INFO - 'HOME': '/home/cltbld', 12:06:00 INFO - 'LANG': 'en_US.UTF-8', 12:06:00 INFO - 'LANGUAGE': 'en_US:en', 12:06:00 INFO - 'LOGNAME': 'cltbld', 12:06:00 INFO - 'MAIL': '/var/mail/cltbld', 12:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:00 INFO - 'MOZ_NO_REMOTE': '1', 12:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:00 INFO - 'NO_EM_RESTART': '1', 12:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:00 INFO - 'PWD': '/builds/slave/test', 12:06:00 INFO - 'SHELL': '/bin/bash', 12:06:00 INFO - 'SHLVL': '1', 12:06:00 INFO - 'TERM': 'linux', 12:06:00 INFO - 'TMOUT': '86400', 12:06:00 INFO - 'USER': 'cltbld', 12:06:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:00 INFO - '_': '/tools/buildbot/bin/python'} 12:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:01 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 12:06:01 INFO - Cleaning up... 12:06:01 INFO - Return code: 0 12:06:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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')]} 12:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:01 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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06:01 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 12:06:01 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 12:06:01 INFO - Using env: {'DISPLAY': ':0', 12:06:01 INFO - 'HOME': '/home/cltbld', 12:06:01 INFO - 'LANG': 'en_US.UTF-8', 12:06:01 INFO - 'LANGUAGE': 'en_US:en', 12:06:01 INFO - 'LOGNAME': 'cltbld', 12:06:01 INFO - 'MAIL': '/var/mail/cltbld', 12:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:01 INFO - 'MOZ_NO_REMOTE': '1', 12:06:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:01 INFO - 'NO_EM_RESTART': '1', 12:06:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:01 INFO - 'PWD': '/builds/slave/test', 12:06:01 INFO - 'SHELL': '/bin/bash', 12:06:01 INFO - 'SHLVL': '1', 12:06:01 INFO - 'TERM': 'linux', 12:06:01 INFO - 'TMOUT': '86400', 12:06:01 INFO - 'USER': 'cltbld', 12:06:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:01 INFO - '_': '/tools/buildbot/bin/python'} 12:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:01 INFO - Downloading/unpacking psutil>=0.7.1 12:06:01 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 12:06:01 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 12:06:01 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 12:06:01 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 12:06:01 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 12:06:01 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 12:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:06:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:03 INFO - Installing collected packages: psutil 12:06:03 INFO - Running setup.py install for psutil 12:06:03 INFO - building 'psutil._psutil_linux' extension 12:06:03 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 12:06:03 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 12:06:03 INFO - building 'psutil._psutil_posix' extension 12:06:03 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 12:06:03 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 12:06:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:06:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:06:03 INFO - Successfully installed psutil 12:06:03 INFO - Cleaning up... 12:06:03 INFO - Return code: 0 12:06:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:06:03 INFO - Using env: {'DISPLAY': ':0', 12:06:03 INFO - 'HOME': '/home/cltbld', 12:06:03 INFO - 'LANG': 'en_US.UTF-8', 12:06:03 INFO - 'LANGUAGE': 'en_US:en', 12:06:03 INFO - 'LOGNAME': 'cltbld', 12:06:03 INFO - 'MAIL': '/var/mail/cltbld', 12:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:03 INFO - 'MOZ_NO_REMOTE': '1', 12:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:03 INFO - 'NO_EM_RESTART': '1', 12:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:03 INFO - 'PWD': '/builds/slave/test', 12:06:03 INFO - 'SHELL': '/bin/bash', 12:06:03 INFO - 'SHLVL': '1', 12:06:03 INFO - 'TERM': 'linux', 12:06:03 INFO - 'TMOUT': '86400', 12:06:03 INFO - 'USER': 'cltbld', 12:06:03 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:03 INFO - '_': '/tools/buildbot/bin/python'} 12:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:06: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 12:06: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 12:06: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 12:06: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 12:06: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 12:06: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 12:06:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:06:05 INFO - Installing collected packages: mozsystemmonitor 12:06:05 INFO - Running setup.py install for mozsystemmonitor 12:06:05 INFO - Successfully installed mozsystemmonitor 12:06:05 INFO - Cleaning up... 12:06:05 INFO - Return code: 0 12:06:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:06: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')]} 12:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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')]} 12:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06: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', '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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:06: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 blobuploader==1.2.4 12:06:05 INFO - Using env: {'DISPLAY': ':0', 12:06:05 INFO - 'HOME': '/home/cltbld', 12:06:05 INFO - 'LANG': 'en_US.UTF-8', 12:06:05 INFO - 'LANGUAGE': 'en_US:en', 12:06:05 INFO - 'LOGNAME': 'cltbld', 12:06:05 INFO - 'MAIL': '/var/mail/cltbld', 12:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:05 INFO - 'MOZ_NO_REMOTE': '1', 12:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:05 INFO - 'NO_EM_RESTART': '1', 12:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:05 INFO - 'PWD': '/builds/slave/test', 12:06:05 INFO - 'SHELL': '/bin/bash', 12:06:05 INFO - 'SHLVL': '1', 12:06:05 INFO - 'TERM': 'linux', 12:06:05 INFO - 'TMOUT': '86400', 12:06:05 INFO - 'USER': 'cltbld', 12:06:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:05 INFO - '_': '/tools/buildbot/bin/python'} 12:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:06 INFO - Downloading/unpacking blobuploader==1.2.4 12:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:06:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:06:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:06: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 12:06: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 12:06: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 12:06: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 12:06: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 12:06: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 12:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:06:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:06: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 12:06: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 12:06: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 12:06: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 12:06: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 12:06: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 12:06:08 INFO - Downloading docopt-0.6.1.tar.gz 12:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:06:08 INFO - Installing collected packages: blobuploader, requests, docopt 12:06:08 INFO - Running setup.py install for blobuploader 12:06:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:06:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:06:08 INFO - Running setup.py install for requests 12:06:09 INFO - Running setup.py install for docopt 12:06:09 INFO - Successfully installed blobuploader requests docopt 12:06:09 INFO - Cleaning up... 12:06:09 INFO - Return code: 0 12:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:09 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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06:09 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 12:06:09 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 12:06:09 INFO - Using env: {'DISPLAY': ':0', 12:06:09 INFO - 'HOME': '/home/cltbld', 12:06:09 INFO - 'LANG': 'en_US.UTF-8', 12:06:09 INFO - 'LANGUAGE': 'en_US:en', 12:06:09 INFO - 'LOGNAME': 'cltbld', 12:06:09 INFO - 'MAIL': '/var/mail/cltbld', 12:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:09 INFO - 'MOZ_NO_REMOTE': '1', 12:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:09 INFO - 'NO_EM_RESTART': '1', 12:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:09 INFO - 'PWD': '/builds/slave/test', 12:06:09 INFO - 'SHELL': '/bin/bash', 12:06:09 INFO - 'SHLVL': '1', 12:06:09 INFO - 'TERM': 'linux', 12:06:09 INFO - 'TMOUT': '86400', 12:06:09 INFO - 'USER': 'cltbld', 12:06:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:09 INFO - '_': '/tools/buildbot/bin/python'} 12:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:09 INFO - Running setup.py (path:/tmp/pip-XOTAom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:09 INFO - Running setup.py (path:/tmp/pip-DQsmHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:09 INFO - Running setup.py (path:/tmp/pip-fUYHlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:09 INFO - Running setup.py (path:/tmp/pip-CnXKNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:09 INFO - Running setup.py (path:/tmp/pip-sGQ9Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:09 INFO - Running setup.py (path:/tmp/pip-Rcap__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:09 INFO - Running setup.py (path:/tmp/pip-bWFftC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:10 INFO - Running setup.py (path:/tmp/pip-I8pyDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:10 INFO - Running setup.py (path:/tmp/pip-a8pP1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:10 INFO - Running setup.py (path:/tmp/pip-F_9yjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:10 INFO - Running setup.py (path:/tmp/pip-FQX3oO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:10 INFO - Running setup.py (path:/tmp/pip-2MEc31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:10 INFO - Running setup.py (path:/tmp/pip-jkE8_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:10 INFO - Running setup.py (path:/tmp/pip-OpTQYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:10 INFO - Running setup.py (path:/tmp/pip-GeBdAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:10 INFO - Running setup.py (path:/tmp/pip-ejfoDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:10 INFO - Running setup.py (path:/tmp/pip-rRtznG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:06:10 INFO - Running setup.py install for manifestparser 12:06:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:06:10 INFO - Running setup.py install for mozcrash 12:06:10 INFO - Running setup.py install for mozdebug 12:06:11 INFO - Running setup.py install for mozdevice 12:06:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Running setup.py install for mozfile 12:06:11 INFO - Running setup.py install for mozhttpd 12:06:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Running setup.py install for mozinfo 12:06:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Running setup.py install for mozInstall 12:06:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Running setup.py install for mozleak 12:06:11 INFO - Running setup.py install for mozlog 12:06:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Running setup.py install for moznetwork 12:06:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:06:11 INFO - Running setup.py install for mozprocess 12:06:11 INFO - Running setup.py install for mozprofile 12:06:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Running setup.py install for mozrunner 12:06:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Running setup.py install for mozscreenshot 12:06:12 INFO - Running setup.py install for moztest 12:06:12 INFO - Running setup.py install for mozversion 12:06:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:06:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:06:12 INFO - Cleaning up... 12:06:12 INFO - Return code: 0 12:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:12 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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06:12 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 12:06:12 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 12:06:12 INFO - Using env: {'DISPLAY': ':0', 12:06:12 INFO - 'HOME': '/home/cltbld', 12:06:12 INFO - 'LANG': 'en_US.UTF-8', 12:06:12 INFO - 'LANGUAGE': 'en_US:en', 12:06:12 INFO - 'LOGNAME': 'cltbld', 12:06:12 INFO - 'MAIL': '/var/mail/cltbld', 12:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:12 INFO - 'MOZ_NO_REMOTE': '1', 12:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:12 INFO - 'NO_EM_RESTART': '1', 12:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:12 INFO - 'PWD': '/builds/slave/test', 12:06:12 INFO - 'SHELL': '/bin/bash', 12:06:12 INFO - 'SHLVL': '1', 12:06:12 INFO - 'TERM': 'linux', 12:06:12 INFO - 'TMOUT': '86400', 12:06:12 INFO - 'USER': 'cltbld', 12:06:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:12 INFO - '_': '/tools/buildbot/bin/python'} 12:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:06:12 INFO - Running setup.py (path:/tmp/pip-ts9ONx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:06:12 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)) 12:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:06:12 INFO - Running setup.py (path:/tmp/pip-ohgD0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:06:12 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)) 12:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:06:12 INFO - Running setup.py (path:/tmp/pip-v7HmjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:06:12 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)) 12:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:06:12 INFO - Running setup.py (path:/tmp/pip-MH3QQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:06:13 INFO - Running setup.py (path:/tmp/pip-8MoVcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:06:13 INFO - Running setup.py (path:/tmp/pip-LYhDL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:06:13 INFO - Running setup.py (path:/tmp/pip-rG04Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:06:13 INFO - Running setup.py (path:/tmp/pip-A116f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:06:13 INFO - Running setup.py (path:/tmp/pip-dGuOom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:06:13 INFO - Running setup.py (path:/tmp/pip-cmFeRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:06:13 INFO - Running setup.py (path:/tmp/pip-U_qbfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:06:13 INFO - Running setup.py (path:/tmp/pip-tHwB3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:06:13 INFO - Running setup.py (path:/tmp/pip-6y0Blw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:06:13 INFO - Running setup.py (path:/tmp/pip-XO5vIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:13 INFO - Running setup.py (path:/tmp/pip-M1U3w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:06:13 INFO - Running setup.py (path:/tmp/pip-n5OJdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:06:13 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)) 12:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:06:13 INFO - Running setup.py (path:/tmp/pip-uLIYss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:06:13 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)) 12:06:13 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)) 12:06:13 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)) 12:06:13 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)) 12:06:13 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)) 12:06:13 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)) 12:06:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:06:13 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 12:06:13 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 12:06:13 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 12:06:13 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 12:06:13 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 12:06:13 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 12:06:15 INFO - Downloading blessings-1.6.tar.gz 12:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:06:15 INFO - Installing collected packages: blessings 12:06:15 INFO - Running setup.py install for blessings 12:06:15 INFO - Successfully installed blessings 12:06:15 INFO - Cleaning up... 12:06:16 INFO - Return code: 0 12:06:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:16 INFO - Reading from file tmpfile_stdout 12:06:16 INFO - Current package versions: 12:06:16 INFO - argparse == 1.2.1 12:06:16 INFO - blessings == 1.6 12:06:16 INFO - blobuploader == 1.2.4 12:06:16 INFO - docopt == 0.6.1 12:06:16 INFO - manifestparser == 1.1 12:06:16 INFO - mozInstall == 1.12 12:06:16 INFO - mozcrash == 0.17 12:06:16 INFO - mozdebug == 0.1 12:06:16 INFO - mozdevice == 0.48 12:06:16 INFO - mozfile == 1.2 12:06:16 INFO - mozhttpd == 0.7 12:06:16 INFO - mozinfo == 0.9 12:06:16 INFO - mozleak == 0.1 12:06:16 INFO - mozlog == 3.1 12:06:16 INFO - moznetwork == 0.27 12:06:16 INFO - mozprocess == 0.22 12:06:16 INFO - mozprofile == 0.28 12:06:16 INFO - mozrunner == 6.11 12:06:16 INFO - mozscreenshot == 0.1 12:06:16 INFO - mozsystemmonitor == 0.0 12:06:16 INFO - moztest == 0.7 12:06:16 INFO - mozversion == 1.4 12:06:16 INFO - psutil == 3.1.1 12:06:16 INFO - requests == 1.2.3 12:06:16 INFO - wsgiref == 0.1.2 12:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:16 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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06:16 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 12:06:16 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 12:06:16 INFO - Using env: {'DISPLAY': ':0', 12:06:16 INFO - 'HOME': '/home/cltbld', 12:06:16 INFO - 'LANG': 'en_US.UTF-8', 12:06:16 INFO - 'LANGUAGE': 'en_US:en', 12:06:16 INFO - 'LOGNAME': 'cltbld', 12:06:16 INFO - 'MAIL': '/var/mail/cltbld', 12:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:16 INFO - 'MOZ_NO_REMOTE': '1', 12:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:16 INFO - 'NO_EM_RESTART': '1', 12:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:16 INFO - 'PWD': '/builds/slave/test', 12:06:16 INFO - 'SHELL': '/bin/bash', 12:06:16 INFO - 'SHLVL': '1', 12:06:16 INFO - 'TERM': 'linux', 12:06:16 INFO - 'TMOUT': '86400', 12:06:16 INFO - 'USER': 'cltbld', 12:06:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:16 INFO - '_': '/tools/buildbot/bin/python'} 12:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 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)) 12:06:16 INFO - Cleaning up... 12:06:16 INFO - Return code: 0 12:06:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:16 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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06:16 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 12:06:16 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 12:06:16 INFO - Using env: {'DISPLAY': ':0', 12:06:16 INFO - 'HOME': '/home/cltbld', 12:06:16 INFO - 'LANG': 'en_US.UTF-8', 12:06:16 INFO - 'LANGUAGE': 'en_US:en', 12:06:16 INFO - 'LOGNAME': 'cltbld', 12:06:16 INFO - 'MAIL': '/var/mail/cltbld', 12:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:16 INFO - 'MOZ_NO_REMOTE': '1', 12:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:16 INFO - 'NO_EM_RESTART': '1', 12:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:16 INFO - 'PWD': '/builds/slave/test', 12:06:16 INFO - 'SHELL': '/bin/bash', 12:06:16 INFO - 'SHLVL': '1', 12:06:16 INFO - 'TERM': 'linux', 12:06:16 INFO - 'TMOUT': '86400', 12:06:16 INFO - 'USER': 'cltbld', 12:06:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:16 INFO - '_': '/tools/buildbot/bin/python'} 12:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:16 INFO - Downloading/unpacking jsonschema 12:06:16 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 12:06:16 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 12:06:16 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 12:06:16 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 12:06:16 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 12:06:16 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 12:06:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:06:18 INFO - Downloading/unpacking functools32 (from jsonschema) 12:06:18 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 12:06:18 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 12:06:18 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 12:06:18 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 12:06:18 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 12:06:18 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 12:06:18 INFO - Downloading functools32-3.2.3-2.tar.gz 12:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:06:18 INFO - warning: no files found matching '*.txt' 12:06:18 INFO - no previously-included directories found matching 'build' 12:06:18 INFO - no previously-included directories found matching 'dist' 12:06:18 INFO - no previously-included directories found matching '.git*' 12:06:18 INFO - Installing collected packages: jsonschema, functools32 12:06:18 INFO - Running setup.py install for functools32 12:06:18 INFO - warning: no files found matching '*.txt' 12:06:18 INFO - no previously-included directories found matching 'build' 12:06:18 INFO - no previously-included directories found matching 'dist' 12:06:18 INFO - no previously-included directories found matching '.git*' 12:06:18 INFO - Successfully installed jsonschema functools32 12:06:18 INFO - Cleaning up... 12:06:18 INFO - Return code: 0 12:06:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:06:18 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')]} 12:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 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')]} 12:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:06:18 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 0x7fa3d3347f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ad9410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', '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 12:06:18 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 12:06:18 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 12:06:18 INFO - Using env: {'DISPLAY': ':0', 12:06:18 INFO - 'HOME': '/home/cltbld', 12:06:18 INFO - 'LANG': 'en_US.UTF-8', 12:06:18 INFO - 'LANGUAGE': 'en_US:en', 12:06:18 INFO - 'LOGNAME': 'cltbld', 12:06:18 INFO - 'MAIL': '/var/mail/cltbld', 12:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:18 INFO - 'MOZ_NO_REMOTE': '1', 12:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:18 INFO - 'NO_EM_RESTART': '1', 12:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:18 INFO - 'PWD': '/builds/slave/test', 12:06:18 INFO - 'SHELL': '/bin/bash', 12:06:18 INFO - 'SHLVL': '1', 12:06:18 INFO - 'TERM': 'linux', 12:06:18 INFO - 'TMOUT': '86400', 12:06:18 INFO - 'USER': 'cltbld', 12:06:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:18 INFO - '_': '/tools/buildbot/bin/python'} 12:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:06:19 INFO - Downloading/unpacking flake8 12:06:19 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 12:06:19 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 12:06:19 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 12:06:19 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 12:06:19 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 12:06:19 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 12:06:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:06:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:06:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 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 12:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:06:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:06:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:06:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:06:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:06:21 INFO - no previously-included directories found matching 'docs/_build' 12:06:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:06:21 INFO - Running setup.py install for pep8 12:06:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:06:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:06:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:06:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:06:21 INFO - no previously-included directories found matching 'docs/_build' 12:06:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:06:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:06:21 INFO - Cleaning up... 12:06:21 INFO - Return code: 0 12:06:21 INFO - Running post-action listener: _resource_record_post_action 12:06:21 INFO - Running post-action listener: _start_resource_monitoring 12:06:21 INFO - Starting resource monitoring. 12:06:21 INFO - ##### 12:06:21 INFO - ##### Running install step. 12:06:21 INFO - ##### 12:06:21 INFO - Running pre-action listener: _resource_record_pre_action 12:06:21 INFO - Running main action method: install 12:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:06:22 INFO - Reading from file tmpfile_stdout 12:06:22 INFO - Detecting whether we're running mozinstall >=1.0... 12:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:06:22 INFO - Reading from file tmpfile_stdout 12:06:22 INFO - Output received: 12:06:22 INFO - Usage: mozinstall [options] installer 12:06:22 INFO - Options: 12:06:22 INFO - -h, --help show this help message and exit 12:06:22 INFO - -d DEST, --destination=DEST 12:06:22 INFO - Directory to install application into. [default: 12:06:22 INFO - "/builds/slave/test"] 12:06:22 INFO - --app=APP Application being installed. [default: firefox] 12:06:22 INFO - mkdir: /builds/slave/test/build/application 12:06:22 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'] 12:06:22 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 12:06:38 INFO - Reading from file tmpfile_stdout 12:06:38 INFO - Output received: 12:06:38 INFO - /builds/slave/test/build/application/firefox/firefox 12:06:38 INFO - Running post-action listener: _resource_record_post_action 12:06:38 INFO - ##### 12:06:38 INFO - ##### Running run-tests step. 12:06:38 INFO - ##### 12:06:38 INFO - Running pre-action listener: _resource_record_pre_action 12:06:38 INFO - Running main action method: run_tests 12:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:06:38 INFO - Python 2.7.3 12:06:38 INFO - Return code: 0 12:06:38 INFO - grabbing minidump binary from tooltool 12:06: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')]} 12:06:38 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 0x1b68160>, '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 0x1b69060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b694f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:06:38 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 12:06:38 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 12:06:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:06:38 INFO - Return code: 0 12:06:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:06:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:06:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:06:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:06:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:06:39 INFO - Return code: 0 12:06:39 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/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 12:06:39 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/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 12:06:39 INFO - Using env: {'DISPLAY': ':0', 12:06:39 INFO - 'HOME': '/home/cltbld', 12:06:39 INFO - 'LANG': 'en_US.UTF-8', 12:06:39 INFO - 'LANGUAGE': 'en_US:en', 12:06:39 INFO - 'LOGNAME': 'cltbld', 12:06:39 INFO - 'MAIL': '/var/mail/cltbld', 12:06:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:06:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:06:39 INFO - 'MOZ_NO_REMOTE': '1', 12:06:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:06:39 INFO - 'NO_EM_RESTART': '1', 12:06:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:06:39 INFO - 'PWD': '/builds/slave/test', 12:06:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:06:39 INFO - 'SHELL': '/bin/bash', 12:06:39 INFO - 'SHLVL': '1', 12:06:39 INFO - 'TERM': 'linux', 12:06:39 INFO - 'TMOUT': '86400', 12:06:39 INFO - 'USER': 'cltbld', 12:06:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037', 12:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:06:39 INFO - '_': '/tools/buildbot/bin/python'} 12:06:39 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/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 12:06:39 INFO - mozversion application_buildid: 20160310104625 12:06:39 INFO - mozversion application_changeset: dd5aaa1e47adcf1506c854a89bb934bb288e6f79 12:06:39 INFO - mozversion application_display_name: Nightly 12:06:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:06:39 INFO - mozversion application_name: Firefox 12:06:39 INFO - mozversion application_remotingname: firefox 12:06:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:06:39 INFO - mozversion application_vendor: Mozilla 12:06:39 INFO - mozversion application_version: 48.0a1 12:06:39 INFO - mozversion platform_buildid: 20160310104625 12:06:39 INFO - mozversion platform_changeset: dd5aaa1e47adcf1506c854a89bb934bb288e6f79 12:06:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:06:39 INFO - mozversion platform_version: 48.0a1 12:06:39 INFO - using testdate: 1457640399 12:06:39 INFO - actual date: 1457640399 12:06:39 INFO - starting webserver on 'localhost:54724' 12:06:39 INFO - SUITE-START | Running 2 tests 12:06:39 INFO - TEST-START | dromaeo_css 12:06:39 INFO - operating with platform_type : linux_ 12:06:39 INFO - Initialising browser for dromaeo_css test... 12:06:39 INFO - TEST-INFO | started process 4184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sXvcA/profile http://localhost:54724/getInfo.html) 12:06:43 INFO - PROCESS | 4184 | __metrics Screen width/height:1600/1200 12:06:43 INFO - PROCESS | 4184 | colorDepth:24 12:06:43 INFO - PROCESS | 4184 | Browser inner width/height: 1024/697 12:06:43 INFO - PROCESS | 4184 | __metrics 12:06:45 ERROR - PROCESS | 4184 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:06:46 INFO - TEST-INFO | 4184: exit 0 12:06:46 INFO - Browser initialized. 12:06:46 INFO - Running cycle 1/1 for dromaeo_css test... 12:06:46 INFO - TEST-INFO | started process 4277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sXvcA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:58 INFO - PROCESS | 4277 | RSS: Main: 154505216 12:06:58 INFO - PROCESS | 4277 | 12:07:49 INFO - PROCESS | 4277 | 1457640469330 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] 12:10:00 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:54724/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54724/tests/dromaeo/cssquery-ext.html) 12:10:01 INFO - PROCESS | 4277 | RSS: Main: 241676288 12:10:01 INFO - PROCESS | 4277 | 12:13:04 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:54724/tests/dromaeo/cssquery-ext.html (next: http://localhost:54724/tests/dromaeo/cssquery-jquery.html) 12:13:04 INFO - PROCESS | 4277 | RSS: Main: 228245504 12:13:04 INFO - PROCESS | 4277 | 12:16:06 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:54724/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54724/tests/dromaeo/cssquery-mootools.html) 12:16:07 INFO - PROCESS | 4277 | RSS: Main: 230674432 12:16:07 INFO - PROCESS | 4277 | 12:19:09 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:54724/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54724/tests/dromaeo/cssquery-prototype.html) 12:19:09 INFO - PROCESS | 4277 | RSS: Main: 215011328 12:19:09 INFO - PROCESS | 4277 | 12:22:12 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:54724/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54724/tests/dromaeo/cssquery-yui.html) 12:22:13 INFO - PROCESS | 4277 | RSS: Main: 197615616 12:22:13 INFO - PROCESS | 4277 | 12:25:15 INFO - PROCESS | 4277 | Cycle 1(1): loaded http://localhost:54724/tests/dromaeo/cssquery-yui.html (next: http://localhost:54724/tests/dromaeo/cssquery-dojo.html) 12:25:16 INFO - PROCESS | 4277 | RSS: Main: 262774784 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - PROCESS | 4277 | __start_tp_report 12:25:16 INFO - PROCESS | 4277 | _x_x_mozilla_page_load 12:25:16 INFO - PROCESS | 4277 | _x_x_mozilla_page_load_details 12:25:16 INFO - PROCESS | 4277 | |i|pagename|runs| 12:25:16 INFO - PROCESS | 4277 | |0;dojo.html;2557.9232623021303;2627.5007748527764;2638.9472210555778;2651.0721247563356;2665.067226470735;4340.066885619591;4448.933266001004;4458.576435238655;4464.7321160730335;4480.686351955361;4475.104979004204;4506.97746511267;4529.932051019237;4557.68096233263;4585.426821647294;4067.4102255172984;4116.053307739222;4210.305299625558;4247.447831781864;4279.893002674927;4024.3158663027357;4183.602557757008;4218.514870789868;4234.30134027885;4243.172581346638;4071.75569465833;4128.401381799622;4135.193637240739;4165.437665915093;4165.58344165584;4136.152088821815;4139.482564679415;4162.396452514368;4166.604172603597;4176.561461046576;4021.296273152216;4100.220958017997;4119.8352065917325;4140.585941405865;4179.456670632799;4393.055493069006;4419.867403977886;4486.730796152208;4494.662900282492;4516.774161291923;4812.566868981773;4836.51634836517;4840.080384726891;4841.975790121062;4856.854294371139;4636.397268355092;4779.784909679072;4839.491853355417;4853.684510506806;4886.1204983103025;4497.820087196541;4527.094581083797;4529.909401811945;4530.048689775152;4531.116432295704;4956.256561515729;4957.6281778866005;4959.504049595083;4965.602751779849;4972.825951091694;4574.313852922089;4623.329617205486;4721.622270218374;4724.598409135193;4779.02030083832;4790;4794.808207671724;4812.711237325701;4814.975925120352;4849.539293767087;4768.546988036131;4769.475357710649;4770.61835053195;4771.618270538349;4819.638527110481;4567.748773817472;4718.245080787126;4779.474257831635;4814.807407703653;4815.2054910940005;3986.461827653288;3994.8402063917697;3998.8800335989968;4016.136530645925;4042.595740425934;3461.705755010802;3525.6121826599056;3532;3546.3971124908826;3570.4822800693755;4112.979435102805;4113.794310284474;4158.6465150462545;4199.139176468817;4199.811008504625;4784.186688262934;4790.760461976887;4803.447603525569;4810.903781924412;4855.028994201174;4073.89815254621;4154.252234597741;4161.126163505637;4178.874633760992;4189.622933935961;4229;4275.551067137968;4277.3797799319545;4303.182395344875;4315.1585440838735;4503.166914120898;4516.367708520876;4524.932126018047;4570.063137056895;4573.405457290664;4696.671233013656;4790.95209047919;4793.664443489062;4796.8081276748535;4836.492168322417;4516.209663308973;4568.771561421982;4573.611243044378;4603.286490593963;4607.838725644587;4667.732950666856;4706;4709.858704238878;4711.505291944297;4749.382580264543;4702.294655801657;4758.452777930583;4763.3807605011125;4764.9047019058735;4797.352357431702;4657.6506761992305;4670.766461676834;4677.485476597503;4679.742614156254;4720.905581888274;4679.578837904605;4680.438347398334;4681.648876334357;4692.906141877212;4710.152172608963;4461.420015397977;4515.887102822456;4598.908021839477;4606;4606.907861842811;4660.161170989254;4673.532646735299;4678.766061696833;4698.271767875985;4717.952820471752;4534.931976020428;4541.205289074464;4541.43232095988;4571.360009598726;4576.4508259009135 12:25:16 INFO - PROCESS | 4277 | |1;ext.html;486.80284484783675;491.2483899633562;500.63453678814466;544.8993034071176;549.5548605629441;24198.87900560497;32882.83558582207;33227.99999999997;33228.33543329138;33265.83367083167;36614.084647883814;37001.25997480055;37053.444198336976;37060.07349816256;37107.81446092772;6730.932690673104;7577.962110189455;7770.067591888953;7781.338586220149;9477.47873866937;9665.710028699115;9798.657047003357;9810.803783924317;9822.901770982306;9825.754356141082;10074.294799364048;10193.082622563968;10208.795824083514;10218.080372766486;10227.079562839343;10003.699889003341;10115.29192956497;10117.392956422638;10121.089101980784;10127.544260508295;9903.900960990442;10071.949640251825;10080.798384032352;10082.19342452602;10083.092521673012;36629.63370366289;36840.63159368399;36903.81548092242;36922.07694807625;36925;2851.158908122109;2973.55396690496;3165.635951865519;3236.96763032369;3699.5930447650735;28391.57412638812;28430;28455;29081.563776543368;29198.708012920022;3479.704225140866;3485.9900697892313;3508.8771892983877;3564.0377098183344;3636.654517820803;223532;224068;224094;225045;225454.87272563696;38027.429588556195;54974.72512637491;56037.15944260839;56073;56074.719626402424;36307.458477906825;36579.81710091486;36606.63393366032;36618;36635.26729465396;13053.086283960221;13231.404586793617;13234.867651323557;13242.404091815892;13251.536196233279;9238.030006849318;10540.578376864993;10894.67315980522;10901.563937442572;10905.509252083675;13027;13069.934650326688;13096.738065238642;13101.541446049534;13216.73566528664;5394.649347792381;5416.485433883775;5449.918251226235;5486.725663716798;5510.393856675762;758.6548120605222;837.4556538250187;837.9944067119359;979.3389462113046;1052.037385792007;25853.353666158495;27053.594196087073;27292.590611140848;27391.315217119733;27530.587041194398;903.7333986473875;915.4095608332589;947.5025611553851;985.261054209343;1031.1080915008463;14029.508967186099;14185.787213191605;14303.254745472526;14411.207383594003;14448.349824257934;249372;253142;253184;254194;254410;45546.544534554894;46411;46419.53580464152;46423;46426;964.3827950111934;1122.5229277557169;1165.1669056624555;1211.7697637448857;1224.0697070226513;23826.642600361356;24269;25169.748302517473;25773.226803195936;27230.5915411265;36304.818475908505;46704.29943550917;47589;47623.047539049716;47644;246957;247528;249585;249802;249966;34132.65867341394;38223.80888095542;38738.22523549457;39104.2179156421;39863.40204896871;35020.47469287912;42042;42106;42129.36805947975;42887;31484.527732083578;33201.50197747084;33861.66138338585;33944.15139621529;34047.808326708444;33173.83413082919;33245.50131748074;33320.66679333176;33709.32581348409;33933.15167120743;33544.1613959653;33630.327393452484;33661.49507757337;35251.82374088113;36199.63800361963;26303.473930521664;27060.34685317457;28594.285142871595;29313.85343073271;30707.79165604583;23965.405189221758;24113.397165071012;24197.637035444834;24200.49354100633;24379 12:25:16 INFO - PROCESS | 4277 | |2;jquery.html;324.21701590658563;330.8759215294265;333.37658578458286;335.1370221679177;338.25797144704785;14527.926519058117;15080.170590617512;15591.84408155918;16068.598285042879;16535.83464165358;11215.214934954536;11775.116866235025;12207.572734954278;14714.705705885875;15575.610609734762;4717.29240613908;4848.345473361086;4875.414950205963;4885.413750349963;4885.487023862496;4738.265568836836;4746.5490778376;4876.780544875489;4894.902101957959;5014.5457817232955;4954.975225123887;4969.70181789092;4976.104301225778;4986.75066246688;4997.725125118117;4897.216445368724;4942.802287908479;4953.133201689726;4955.083309587738;4956.826511072113;4273.423087883127;4407.338899165119;4412.382266482695;4416.028473735773;4418.204723149832;17943.282268709238;18201.08994550267;18564.350247741266;18692.719609205873;18776.061196940234;1782.4296225207938;1799.9460016199534;1811.5652243461475;1832.2854086906118;1925.3261358524544;12009;12453;12524.436400362005;12831.294278814661;12949.935250323782;1731.6190438103722;1738.4610770661009;1778.4931294580983;1779.3861117914298;1785.3840425053336;56764.43235567633;57342.42657573454;57371.713141434026;57491.13763293512;57871.710641446945;8800.559972001374;8842.955785221033;8942.552872356357;8973.461592304482;9128.90871091294;10911.290766100337;10943.562257509611;10963.177761667906;10978.396188209725;11085.83371249432;7074.6816393262425;7136.678849451787;7156.427485801123;7188.676509557083;7230.493865429475;7083.964580177169;7153.141623005273;7267.236940121317;7284.6721897514735;7300.4159667226495;5461.781528738886;5555.138953462219;5559.27729395176;5593.440655934455;5644.3508996465935;1630.2582325042076;1647.5057482755126;1654.073718717522;1659.2450435052021;1690.2562872336132;843.9577122254011;854.6752234150982;870.629982257538;879.2438502887512;894.9707835988665;15325.846741532665;15417.845821541865;15815.604609884846;16016.75974860378;16230;815.9637260678904;851.3614788908319;877.6928075173638;884.3014018925106;911.2709832134266;9047.547622618842;9134.70382062699;9243.90756092444;9442;9518;217781;220569;361037;361524;367974;50600.74699626478;72723.63638181775;72862;74198.62900685462;74862;842.1914961636775;871.4553404122423;873.7946582553095;875.8088998961407;877.3069275272463;13480.73038539204;14132.78800818009;14328.068675536057;14355.354009069826;14355.425782968565;30499.847500762353;31346.529802053443;31428;31467;31825.6817431832;42362.5763742371;42560.78719606382;42755;42902.78548607237;43737;7169.426445884213;7294.307040831112;7366.189719130784;7411.036565246699;7484.513506622052;10108.292419530562;10971.945140274247;11013.118950484102;11179.888201117885;11374.886251137714;9297.907020929704;9598.232141428809;9666.371685840399;9701.854472183064;9726.416415015121;9598;9886.357386769838;9917.702468925943;9941.950290248502;10062.547185376528;9548.856767148638;9616.423014619146;9739.707808765748;9764.170045546209;10098.141657959155;7192.029076074663;7296.7810965671115;7307.26927307265;7307.3423391894985;7442.292982166686;7740.883886741591;8772.56137193125;9104.817903642022;9456.574454149717;10159.44123073238 12:25:16 INFO - PROCESS | 4277 | |3;mootools.html;1279.0087682046408;1349.6086135020848;1353.9323033848304;1484.3988184785167;1748.5278974676837;6555.868882622344;7196.064511613489;7321.194668586451;7334.816629584263;7338;7197.784066478001;7367.336939675428;7368.078990126234;7369.226231245722;7371.299726525972;1785.0628420079497;1822.5079228608267;1824.9908750456295;2093.8743675379487;2123.3205374280237;2085.4369320283513;2130.659094544873;2131.07298325229;2133.7332833395826;2134.157007981846;2073.9274125405614;2076.615826072174;2077.054940002303;2077.1898959405844;2095.6437405641;2127.9787202127936;2139.3047259640603;2140.32579737383;2140.7003019577273;2140.7324084489437;2032.5325175209637;2080.4694802825184;2084.3538503064096;2085.35354040248;2093.110428068065;7419.332260096563;7473.476856620039;7477.5887326197035;7481.7007319707145;7487.9625601872185;4188.246115699173;4301.612854843048;4303.505096913864;4313.870583882489;4320.503142138663;2708.038646280562;2782.5130602144545;2811.7469427751603;2827.9293017674518;2832.603435519029;871.1288711288711;876.5617191404298;881.8765372847806;894.0165817600653;920.0569416348229;10118.696439106838;10132.54403551842;10134.847977280348;10152.340097893613;10159.23805714567;3867.4972253607416;3991.261616600938;4058.228936502055;4062.878113656595;4075.042365044212;8657.610407531676;8720.781980450412;8732.78168045804;8735.25750311218;8776.60505277264;4237.131388065439;4238.237117318912;4248.808803603783;4265.616094551443;4266;3429.794212347217;3739.2147648993473;3762.3792074307435;3832.9616703833162;3861.189150278417;3288.1122097034145;3337.4159522083537;3369.309291595266;3373.8313084345687;3395.8132302723093;1059.3114475590928;1063.5320458998017;1067.8771941226703;1070.710908054821;1074.9516271767789;890.0387581412189;891.3136884598823;899.5906862377733;907.2515174980535;1042.4475028235047;7136.750213742494;7146.2496437874315;7166.892496612555;7169.749058782918;7174.497785154989;428.34890965732535;429.69276966968766;432.8831215571778;1054.2936232724094;1111.111111111108;5435.2934118564335;5457.536109430664;5471.835844924659;5525.806596769094;5528.944710552923;8333.583320833934;8592.828143437097;8649.351298652626;8664;8680.6527738891;8379;8411.285040771481;8424.368172387096;8448.408611397266;8509.61706723199;6964.582125072512;7163.820904477326;7239.782806515707;7245.963770181115;7253.165885923081;6733.158355205599;6737.090492783412;6805.353491418307;6810.523263371517;6813.4208592270215;8027.799305017421;8131.9593402032615;8220.424570280024;8278.586070696561;8319.750407487785;8217.30152937007;8426.368022398467;8435.409521333448;8494.74515764528;8529;5208.296879921162;5628.296462942132;5910.320313163869;5955.40445955401;6013.609115407485;6873.5875847449315;6884.070650462324;6939.583624982517;6943.548669336477;6947.5831450113155;6005.729742161526;6168.599041062316;6225.066240063846;6265.718042688181;6398.584092034003;5974.910376344272;6016.969915150396;6039.698015099315;6112.144299798121;6133.141360209485;6263.686815659108;6330.873382532415;6334.714937827901;6350.587211831216;6356.904646430215;5841.474267315962;5861;5876.647401155944;5883.058710606282;5894.263217097863;6031.520968533545;6048.0625503047095;6049.637021778707;6062.060380641008;6062.090686397076 12:25:16 INFO - PROCESS | 4277 | |4;prototype.html;283.6213654770881;297.27316710642475;304.0938004745858;307.75687207106387;308.28324146359716;5282.577393808496;5344.946550534499;5352.090144675405;5372.194170874371;5380.273663055491;5268.710220937847;5279.653688309476;5282.366116066068;5284.339457567804;5296.126139187029;3892.7275090743587;4008.639222469977;4126.66986641068;4127.62851343379;4131.876043718693;4126.0510082681;4126.5667104954;4128.256913755523;4128.256913755523;4143.9171216575805;3843.577206507282;4092.1815636872598;4094.877153685379;4098.221337945795;4101.8974525636795;3971.225611005855;4068.6541643960004;4085.060436099684;4085.0808568072243;4091.0386059276047;3577.3918433866306;3580.982095089534;3587.1749497615697;3588.174719814457;3590.694790942773;5088.058709138784;5092.465291144414;5093.752030752452;5100.923486147711;5101.744912754348;4691.507391723854;4693.671442998992;4694.882627934329;4695.60087392572;4702.788374523155;5523.834284971457;5526.032944234743;5532.197831314437;5533.197686335499;5536.280283563111;3802.277567262239;3910.765354078736;3914;3916;3920.2551515212017;5694.060480020791;5742.483176514133;5760.481556659879;5764.481196692318;5781.942180578182;4053;4058.0869304406274;4059.817308221137;4061.3298805696727;4061.9796901015307;4114.670826333886;4121.91756164875;4122.361034039729;4123.484564429446;4124.298869192245;4678.532146785362;4679.27471241958;4681.50844161365;4690.460597031385;4691.061787642485;5582.106862901997;5584.609077364546;5585.413531579207;5585.69278689676;5586.190002449622;1404.831420229579;1431.5633731711719;1452.1795185720034;1454.4400405843614;1457.4316016753476;929.1962452478692;981.47000619666;985.5121714751101;1005.8994100589882;1006.6325791086201;4803.375561177025;4814.398200224972;4817.855464336076;4861;4877.292792545061;5726.570507211893;5727.856803579861;5728.255326807488;5728.513076388554;5737.483626473638;4861.295112208781;4862.367892174066;4865.9756701216265;4868.95131048692;4879.170541008037;3018.9698103019127;3072.8770849165785;3073.339232065117;3074.508078707396;3079.045495896279;5390.353157621111;5397.3523177218985;5400.513953744182;5409.26974858397;5410.026195284887;5725.141228815711;5972.223610930551;5991.041433370639;5993.370696076936;6006.069059295816;5456.099743542271;5465.754041068161;5485.588580856452;5487.4238204987905;5489.313835770528;5803.984302746918;5813.563982701399;5819.5344372450945;5819.952408566499;5820.447057529528;5700.401457846866;5711.600187986801;5712.885742285214;5717.42825717425;5720.542356611378;5343.382754004036;5471.37079235893;5474.835754927359;5479;5488.670679759227;3847.249786291646;3902.9414558781073;3925.6270654287796;3929.115948911472;3935.6654684351006;5750.453706897838;5765.394633563583;5769.173105178348;5780.971095144498;5785.363610002981;5575.581831362745;5578.30271216098;5583.69289689071;5589.413111623384;5589.692566908859;5570.86072848182;5574.331080270394;5574.637648552831;5581.581381396492;5583.888322233452;5316.494932981361;5467.753951072132;5471.917921231265;5474.5894057945015;5479.178123281539;5537.058700020925;5615.803446879339;5616.915746263891;5617.045102332531;5624.803131890364;5370.892582148414;5402;5403.567714582745;5403.891922161613;5409.323834520685 12:25:16 INFO - PROCESS | 4277 | |5;yui.html;614.0635530815507;632.7310892870529;634.3561285295423;709.9432045436365;712.4442934511081;11350.545978160873;11449.026832719228;11461.255018423797;11478.426078696053;11659.475323610437;11130.38782866942;11182.776344473126;11201.383923884183;11217.214794964355;11234.606788762374;598.9161517387569;782.5109306683323;801.6112185590014;809.0938149272794;810.2545657994659;793.4128744728916;798.1220657276978;800.6437135474716;801.0947629179049;801.3629164813958;822.7696245051366;827.028241815867;828.3456069704926;829.1832544943226;833.8999320081599;638.7476946606112;821.2813787935556;833.6998680475024;836.017679226912;837.811492414208;610.2920612089954;612.7212118486123;616.747133675191;617.0466629058116;617.0528239152924;11903.821442678367;11967.281963082243;11968.521259149624;12005.699857503545;12017.63947081589;11153.163512736577;11584.710382240428;11693;12113.454894529767;12222.633321000385;9482.478463684494;9518.476483793389;9571.18644915183;9603.423794572349;9608.807823843485;3191.5053166758958;3200.5519227308196;3242.0435971388497;3272.132884785534;3321.618013928381;39891.60108398908;40215.597844021475;40351.39472907879;40358.39462408066;40517.79741101305;9536.904630953602;9684.176844968257;9816.411015339103;9957.402555846673;10112.696619101438;16813.243404046847;16839.579010524834;16939.49181524556;16962.83037169637;16986.320547177973;6473.805785826433;6497.090407342976;6508.981147013632;6548.574342667712;6593.044008618724;3560.6795388415167;3616.294822509585;3640.4175331946763;3682.742208045465;3729.4405839124347;2717.4293398386562;2729.3040274730215;2750.4499100180046;2766.363736340613;2769.8753556090023;452.2334642780456;467.9321498382715;486.13225392674616;493.96048316134625;496.74417674897455;501.83941138835223;521.9556337711338;586.4399498479028;592.8399332180287;599.340725202274;7472.701091956261;7628.237176282439;7636.951968793107;7812.726554570563;7890.289873911375;582.9387914269025;590.0912594604262;598.6378241164033;606.6451126091198;609.9451049405575;3507.8070706111407;3522.454019626962;3555.591107022674;3571.62497937718;3573.160307327776;46266.53733462622;47149.5285047152;47450.76274618605;47598.28602570964;47730.76134619374;43327.35008974868;43411.34882976758;43474.782626086664;43795.781021095325;44490.33264501035;39247.41128883069;39280.2143957125;39400.80299598541;40110.59889401068;40679;6797.524173307821;6930.584164950119;6938.548994315353;7047.964760176166;7102.467314951503;30598.388032239676;30737.38525229438;31451.685483144876;31605.52591711172;32012.6798732019;36047.098822529646;36152.819235903655;36488.27023459463;39004.414933776585;39085.804570976965;9445.669401570913;9564.187044101329;10072.395656260647;10102.39385636864;10168.84746728785;8517.490392879457;10633.574657013633;10805.135589153006;11025.44872756343;11117.555297787998;9860.359076659994;9947.900520994986;10036.347637403545;10696.83954740664;11199;9953.701388958343;10053.49732513386;10296.536655850654;10570.8414373786;10727.731806704895;9852.458114803754;9951.303408761607;10894.61868834587;10969.067629251604;10982.780344392908;8401.831963360577;8570.871436928326;8709.825803484022;8796.032436432115;8879;8352.33181345503;8741.125887411208;9104.863427048467;9208.171264585952;9216.677416290398 12:25:16 INFO - PROCESS | 4277 | __end_tp_report 12:25:16 INFO - PROCESS | 4277 | __start_cc_report 12:25:16 INFO - PROCESS | 4277 | _x_x_mozilla_cycle_collect,814 12:25:16 INFO - PROCESS | 4277 | __end_cc_report 12:25:16 INFO - PROCESS | 4277 | __startTimestamp1457641516110__endTimestamp 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - PROCESS | 4277 | ------- Summary: start ------- 12:25:16 INFO - PROCESS | 4277 | Number of tests: 6 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - PROCESS | 4277 | [#0] dojo.html Cycles:165 Average:4437.12 Median:4557.68 stddev:448.96 (9.9%) stddev-sans-first:425.45 12:25:16 INFO - PROCESS | 4277 | Values: 2557.9 2627.5 2638.9 2651.1 2665.1 4340.1 4448.9 4458.6 4464.7 4480.7 4475.1 4507.0 4529.9 4557.7 4585.4 4067.4 4116.1 4210.3 4247.4 4279.9 4024.3 4183.6 4218.5 4234.3 4243.2 4071.8 4128.4 4135.2 4165.4 4165.6 4136.2 4139.5 4162.4 4166.6 4176.6 4021.3 4100.2 4119.8 4140.6 4179.5 4393.1 4419.9 4486.7 4494.7 4516.8 4812.6 4836.5 4840.1 4842.0 4856.9 4636.4 4779.8 4839.5 4853.7 4886.1 4497.8 4527.1 4529.9 4530.0 4531.1 4956.3 4957.6 4959.5 4965.6 4972.8 4574.3 4623.3 4721.6 4724.6 4779.0 4790.0 4794.8 4812.7 4815.0 4849.5 4768.5 4769.5 4770.6 4771.6 4819.6 4567.7 4718.2 4779.5 4814.8 4815.2 3986.5 3994.8 3998.9 4016.1 4042.6 3461.7 3525.6 3532.0 3546.4 3570.5 4113.0 4113.8 4158.6 4199.1 4199.8 4784.2 4790.8 4803.4 4810.9 4855.0 4073.9 4154.3 4161.1 4178.9 4189.6 4229.0 4275.6 4277.4 4303.2 4315.2 4503.2 4516.4 4524.9 4570.1 4573.4 4696.7 4791.0 4793.7 4796.8 4836.5 4516.2 4568.8 4573.6 4603.3 4607.8 4667.7 4706.0 4709.9 4711.5 4749.4 4702.3 4758.5 4763.4 4764.9 4797.4 4657.7 4670.8 4677.5 4679.7 4720.9 4679.6 4680.4 4681.6 4692.9 4710.2 4461.4 4515.9 4598.9 4606.0 4606.9 4660.2 4673.5 4678.8 4698.3 4718.0 4534.9 4541.2 4541.4 4571.4 4576.5 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - PROCESS | 4277 | [#1] ext.html Cycles:180 Average:39995.02 Median:33255.67 stddev:62972.11 (189.4%) stddev-sans-first:63078.89 12:25:16 INFO - PROCESS | 4277 | Values: 486.8 491.2 500.6 544.9 549.6 24198.9 32882.8 33228.0 33228.3 33265.8 36614.1 37001.3 37053.4 37060.1 37107.8 6730.9 7578.0 7770.1 7781.3 9477.5 9665.7 9798.7 9810.8 9822.9 9825.8 10074.3 10193.1 10208.8 10218.1 10227.1 10003.7 10115.3 10117.4 10121.1 10127.5 9903.9 10071.9 10080.8 10082.2 10083.1 36629.6 36840.6 36903.8 36922.1 36925.0 2851.2 2973.6 3165.6 3237.0 3699.6 28391.6 28430.0 28455.0 29081.6 29198.7 3479.7 3486.0 3508.9 3564.0 3636.7 223532.0 224068.0 224094.0 225045.0 225454.9 38027.4 54974.7 56037.2 56073.0 56074.7 36307.5 36579.8 36606.6 36618.0 36635.3 13053.1 13231.4 13234.9 13242.4 13251.5 9238.0 10540.6 10894.7 10901.6 10905.5 13027.0 13069.9 13096.7 13101.5 13216.7 5394.6 5416.5 5449.9 5486.7 5510.4 758.7 837.5 838.0 979.3 1052.0 25853.4 27053.6 27292.6 27391.3 27530.6 903.7 915.4 947.5 985.3 1031.1 14029.5 14185.8 14303.3 14411.2 14448.3 249372.0 253142.0 253184.0 254194.0 254410.0 45546.5 46411.0 46419.5 46423.0 46426.0 964.4 1122.5 1165.2 1211.8 1224.1 23826.6 24269.0 25169.7 25773.2 27230.6 36304.8 46704.3 47589.0 47623.0 47644.0 246957.0 247528.0 249585.0 249802.0 249966.0 34132.7 38223.8 38738.2 39104.2 39863.4 35020.5 42042.0 42106.0 42129.4 42887.0 31484.5 33201.5 33861.7 33944.2 34047.8 33173.8 33245.5 33320.7 33709.3 33933.2 33544.2 33630.3 33661.5 35251.8 36199.6 26303.5 27060.3 28594.3 29313.9 30707.8 23965.4 24113.4 24197.6 24200.5 24379.0 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - PROCESS | 4277 | [#2] jquery.html Cycles:180 Average:20585.85 Median:4890.19 stddev:51977.32 (1062.9%) stddev-sans-first:52100.87 12:25:16 INFO - PROCESS | 4277 | Values: 324.2 330.9 333.4 335.1 338.3 14527.9 15080.2 15591.8 16068.6 16535.8 11215.2 11775.1 12207.6 14714.7 15575.6 4717.3 4848.3 4875.4 4885.4 4885.5 4738.3 4746.5 4876.8 4894.9 5014.5 4955.0 4969.7 4976.1 4986.8 4997.7 4897.2 4942.8 4953.1 4955.1 4956.8 4273.4 4407.3 4412.4 4416.0 4418.2 17943.3 18201.1 18564.4 18692.7 18776.1 1782.4 1799.9 1811.6 1832.3 1925.3 12009.0 12453.0 12524.4 12831.3 12949.9 1731.6 1738.5 1778.5 1779.4 1785.4 56764.4 57342.4 57371.7 57491.1 57871.7 8800.6 8843.0 8942.6 8973.5 9128.9 10911.3 10943.6 10963.2 10978.4 11085.8 7074.7 7136.7 7156.4 7188.7 7230.5 7084.0 7153.1 7267.2 7284.7 7300.4 5461.8 5555.1 5559.3 5593.4 5644.4 1630.3 1647.5 1654.1 1659.2 1690.3 844.0 854.7 870.6 879.2 895.0 15325.8 15417.8 15815.6 16016.8 16230.0 816.0 851.4 877.7 884.3 911.3 9047.5 9134.7 9243.9 9442.0 9518.0 217781.0 220569.0 361037.0 361524.0 367974.0 50600.7 72723.6 72862.0 74198.6 74862.0 842.2 871.5 873.8 875.8 877.3 13480.7 14132.8 14328.1 14355.4 14355.4 30499.8 31346.5 31428.0 31467.0 31825.7 42362.6 42560.8 42755.0 42902.8 43737.0 7169.4 7294.3 7366.2 7411.0 7484.5 10108.3 10971.9 11013.1 11179.9 11374.9 9297.9 9598.2 9666.4 9701.9 9726.4 9598.0 9886.4 9917.7 9942.0 10062.5 9548.9 9616.4 9739.7 9764.2 10098.1 7192.0 7296.8 7307.3 7307.3 7442.3 7740.9 8772.6 9104.8 9456.6 10159.4 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - PROCESS | 4277 | [#3] mootools.html Cycles:180 Average:5055.73 Median:5990.32 stddev:2700.05 (45.1%) stddev-sans-first:2692.71 12:25:16 INFO - PROCESS | 4277 | Values: 1279.0 1349.6 1353.9 1484.4 1748.5 6555.9 7196.1 7321.2 7334.8 7338.0 7197.8 7367.3 7368.1 7369.2 7371.3 1785.1 1822.5 1825.0 2093.9 2123.3 2085.4 2130.7 2131.1 2133.7 2134.2 2073.9 2076.6 2077.1 2077.2 2095.6 2128.0 2139.3 2140.3 2140.7 2140.7 2032.5 2080.5 2084.4 2085.4 2093.1 7419.3 7473.5 7477.6 7481.7 7488.0 4188.2 4301.6 4303.5 4313.9 4320.5 2708.0 2782.5 2811.7 2827.9 2832.6 871.1 876.6 881.9 894.0 920.1 10118.7 10132.5 10134.8 10152.3 10159.2 3867.5 3991.3 4058.2 4062.9 4075.0 8657.6 8720.8 8732.8 8735.3 8776.6 4237.1 4238.2 4248.8 4265.6 4266.0 3429.8 3739.2 3762.4 3833.0 3861.2 3288.1 3337.4 3369.3 3373.8 3395.8 1059.3 1063.5 1067.9 1070.7 1075.0 890.0 891.3 899.6 907.3 1042.4 7136.8 7146.2 7166.9 7169.7 7174.5 428.3 429.7 432.9 1054.3 1111.1 5435.3 5457.5 5471.8 5525.8 5528.9 8333.6 8592.8 8649.4 8664.0 8680.7 8379.0 8411.3 8424.4 8448.4 8509.6 6964.6 7163.8 7239.8 7246.0 7253.2 6733.2 6737.1 6805.4 6810.5 6813.4 8027.8 8132.0 8220.4 8278.6 8319.8 8217.3 8426.4 8435.4 8494.7 8529.0 5208.3 5628.3 5910.3 5955.4 6013.6 6873.6 6884.1 6939.6 6943.5 6947.6 6005.7 6168.6 6225.1 6265.7 6398.6 5974.9 6017.0 6039.7 6112.1 6133.1 6263.7 6330.9 6334.7 6350.6 6356.9 5841.5 5861.0 5876.6 5883.1 5894.3 6031.5 6048.1 6049.6 6062.1 6062.1 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - PROCESS | 4277 | [#4] prototype.html Cycles:180 Average:4617.06 Median:5283.46 stddev:1355.03 (25.6%) stddev-sans-first:1319.21 12:25:16 INFO - PROCESS | 4277 | Values: 283.6 297.3 304.1 307.8 308.3 5282.6 5344.9 5352.1 5372.2 5380.3 5268.7 5279.7 5282.4 5284.3 5296.1 3892.7 4008.6 4126.7 4127.6 4131.9 4126.1 4126.6 4128.3 4128.3 4143.9 3843.6 4092.2 4094.9 4098.2 4101.9 3971.2 4068.7 4085.1 4085.1 4091.0 3577.4 3581.0 3587.2 3588.2 3590.7 5088.1 5092.5 5093.8 5100.9 5101.7 4691.5 4693.7 4694.9 4695.6 4702.8 5523.8 5526.0 5532.2 5533.2 5536.3 3802.3 3910.8 3914.0 3916.0 3920.3 5694.1 5742.5 5760.5 5764.5 5781.9 4053.0 4058.1 4059.8 4061.3 4062.0 4114.7 4121.9 4122.4 4123.5 4124.3 4678.5 4679.3 4681.5 4690.5 4691.1 5582.1 5584.6 5585.4 5585.7 5586.2 1404.8 1431.6 1452.2 1454.4 1457.4 929.2 981.5 985.5 1005.9 1006.6 4803.4 4814.4 4817.9 4861.0 4877.3 5726.6 5727.9 5728.3 5728.5 5737.5 4861.3 4862.4 4866.0 4869.0 4879.2 3019.0 3072.9 3073.3 3074.5 3079.0 5390.4 5397.4 5400.5 5409.3 5410.0 5725.1 5972.2 5991.0 5993.4 6006.1 5456.1 5465.8 5485.6 5487.4 5489.3 5804.0 5813.6 5819.5 5820.0 5820.4 5700.4 5711.6 5712.9 5717.4 5720.5 5343.4 5471.4 5474.8 5479.0 5488.7 3847.2 3902.9 3925.6 3929.1 3935.7 5750.5 5765.4 5769.2 5781.0 5785.4 5575.6 5578.3 5583.7 5589.4 5589.7 5570.9 5574.3 5574.6 5581.6 5583.9 5316.5 5467.8 5471.9 5474.6 5479.2 5537.1 5615.8 5616.9 5617.0 5624.8 5370.9 5402.0 5403.6 5403.9 5409.3 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - PROCESS | 4277 | [#5] yui.html Cycles:180 Average:11994.77 Median:23808.73 stddev:13409.83 (56.3%) stddev-sans-first:13420.21 12:25:16 INFO - PROCESS | 4277 | Values: 614.1 632.7 634.4 709.9 712.4 11350.5 11449.0 11461.3 11478.4 11659.5 11130.4 11182.8 11201.4 11217.2 11234.6 598.9 782.5 801.6 809.1 810.3 793.4 798.1 800.6 801.1 801.4 822.8 827.0 828.3 829.2 833.9 638.7 821.3 833.7 836.0 837.8 610.3 612.7 616.7 617.0 617.1 11903.8 11967.3 11968.5 12005.7 12017.6 11153.2 11584.7 11693.0 12113.5 12222.6 9482.5 9518.5 9571.2 9603.4 9608.8 3191.5 3200.6 3242.0 3272.1 3321.6 39891.6 40215.6 40351.4 40358.4 40517.8 9536.9 9684.2 9816.4 9957.4 10112.7 16813.2 16839.6 16939.5 16962.8 16986.3 6473.8 6497.1 6509.0 6548.6 6593.0 3560.7 3616.3 3640.4 3682.7 3729.4 2717.4 2729.3 2750.4 2766.4 2769.9 452.2 467.9 486.1 494.0 496.7 501.8 522.0 586.4 592.8 599.3 7472.7 7628.2 7637.0 7812.7 7890.3 582.9 590.1 598.6 606.6 609.9 3507.8 3522.5 3555.6 3571.6 3573.2 46266.5 47149.5 47450.8 47598.3 47730.8 43327.4 43411.3 43474.8 43795.8 44490.3 39247.4 39280.2 39400.8 40110.6 40679.0 6797.5 6930.6 6938.5 7048.0 7102.5 30598.4 30737.4 31451.7 31605.5 32012.7 36047.1 36152.8 36488.3 39004.4 39085.8 9445.7 9564.2 10072.4 10102.4 10168.8 8517.5 10633.6 10805.1 11025.4 11117.6 9860.4 9947.9 10036.3 10696.8 11199.0 9953.7 10053.5 10296.5 10570.8 10727.7 9852.5 9951.3 10894.6 10969.1 10982.8 8401.8 8570.9 8709.8 8796.0 8879.0 8352.3 8741.1 9104.9 9208.2 9216.7 12:25:16 INFO - PROCESS | 4277 | -------- Summary: end -------- 12:25:16 INFO - PROCESS | 4277 | 12:25:16 INFO - TEST-INFO | 4277: exit 0 12:25:16 INFO - TEST-OK | dromaeo_css | took 1117567ms 12:25:16 INFO - TEST-START | kraken 12:25:16 INFO - operating with platform_type : linux_ 12:25:16 INFO - Initialising browser for kraken test... 12:25:16 INFO - TEST-INFO | started process 4458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqM61GU/profile http://localhost:54724/getInfo.html) 12:25:21 INFO - PROCESS | 4458 | __metrics Screen width/height:1600/1200 12:25:21 INFO - PROCESS | 4458 | colorDepth:24 12:25:21 INFO - PROCESS | 4458 | Browser inner width/height: 1024/697 12:25:21 INFO - PROCESS | 4458 | __metrics 12:25:22 ERROR - PROCESS | 4458 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:25:22 INFO - PROCESS | 4458 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:25:23 INFO - TEST-INFO | 4458: exit 0 12:25:23 INFO - Browser initialized. 12:25:23 INFO - Running cycle 1/1 for kraken test... 12:25:23 INFO - TEST-INFO | started process 4540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqM61GU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:35 INFO - PROCESS | 4540 | RSS: Main: 154013696 12:25:35 INFO - PROCESS | 4540 | 12:25:37 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54724/tests/kraken/driver.html?testName=audio-beat-detection) 12:25:38 INFO - PROCESS | 4540 | RSS: Main: 195117056 12:25:38 INFO - PROCESS | 4540 | 12:25:41 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54724/tests/kraken/driver.html?testName=audio-dft) 12:25:41 INFO - PROCESS | 4540 | RSS: Main: 185409536 12:25:41 INFO - PROCESS | 4540 | 12:25:44 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54724/tests/kraken/driver.html?testName=audio-fft) 12:25:45 INFO - PROCESS | 4540 | RSS: Main: 172371968 12:25:45 INFO - PROCESS | 4540 | 12:25:47 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54724/tests/kraken/driver.html?testName=audio-oscillator) 12:25:47 INFO - PROCESS | 4540 | RSS: Main: 172974080 12:25:47 INFO - PROCESS | 4540 | 12:25:50 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54724/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:25:50 INFO - PROCESS | 4540 | RSS: Main: 173703168 12:25:50 INFO - PROCESS | 4540 | 12:25:53 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54724/tests/kraken/driver.html?testName=imaging-darkroom) 12:25:54 INFO - PROCESS | 4540 | RSS: Main: 174534656 12:25:54 INFO - PROCESS | 4540 | 12:25:58 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54724/tests/kraken/driver.html?testName=imaging-desaturate) 12:25:58 INFO - PROCESS | 4540 | RSS: Main: 172306432 12:25:58 INFO - PROCESS | 4540 | 12:26:01 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54724/tests/kraken/driver.html?testName=json-parse-financial) 12:26:02 INFO - PROCESS | 4540 | RSS: Main: 174415872 12:26:02 INFO - PROCESS | 4540 | 12:26:03 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54724/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:26:04 INFO - PROCESS | 4540 | RSS: Main: 184066048 12:26:04 INFO - PROCESS | 4540 | 12:26:06 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54724/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:26:06 INFO - PROCESS | 4540 | RSS: Main: 181567488 12:26:06 INFO - PROCESS | 4540 | 12:26:09 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54724/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:26:09 INFO - PROCESS | 4540 | RSS: Main: 192983040 12:26:09 INFO - PROCESS | 4540 | 12:26:12 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:26:12 INFO - PROCESS | 4540 | RSS: Main: 198656000 12:26:12 INFO - PROCESS | 4540 | 12:26:15 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:26:16 INFO - PROCESS | 4540 | RSS: Main: 197279744 12:26:16 INFO - PROCESS | 4540 | 12:26:17 INFO - PROCESS | 4540 | Cycle 1(1): loaded http://localhost:54724/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54724/tests/kraken/driver.html?testName=ai-astar) 12:26:18 INFO - PROCESS | 4540 | RSS: Main: 258129920 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | __start_tp_report 12:26:18 INFO - PROCESS | 4540 | _x_x_mozilla_page_load 12:26:18 INFO - PROCESS | 4540 | _x_x_mozilla_page_load_details 12:26:18 INFO - PROCESS | 4540 | |i|pagename|runs| 12:26:18 INFO - PROCESS | 4540 | |0;ai-astar;111;114;108;113;114;115;103;112;113;114 12:26:18 INFO - PROCESS | 4540 | |1;audio-beat-detection;155;136;154;181;147;155;163;138;187;134 12:26:18 INFO - PROCESS | 4540 | |2;audio-dft;160;162;161;161;162;162;163;163;162;170 12:26:18 INFO - PROCESS | 4540 | |3;audio-fft;75;76;100;97;73;76;73;107;100;73 12:26:18 INFO - PROCESS | 4540 | |4;audio-oscillator;95;94;143;94;94;95;131;94;95;139 12:26:18 INFO - PROCESS | 4540 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;117;117;117 12:26:18 INFO - PROCESS | 4540 | |6;imaging-darkroom;145;147;146;146;146;146;146;147;147;147 12:26:18 INFO - PROCESS | 4540 | |7;imaging-desaturate;95;95;96;96;96;95;96;97;96;96 12:26:18 INFO - PROCESS | 4540 | |8;json-parse-financial;66;66;66;66;66;65;65;74;64;63 12:26:18 INFO - PROCESS | 4540 | |9;json-stringify-tinderbox;70;69;70;70;78;69;69;73;72;69 12:26:18 INFO - PROCESS | 4540 | |10;stanford-crypto-aes;84;85;85;83;94;84;85;90;84;84 12:26:18 INFO - PROCESS | 4540 | |11;stanford-crypto-ccm;123;129;120;122;125;123;130;120;130;128 12:26:18 INFO - PROCESS | 4540 | |12;stanford-crypto-pbkdf2;142;140;155;148;149;138;148;147;149;153 12:26:18 INFO - PROCESS | 4540 | |13;stanford-crypto-sha256-iterative;71;72;72;71;70;70;69;70;71;70 12:26:18 INFO - PROCESS | 4540 | __end_tp_report 12:26:18 INFO - PROCESS | 4540 | __start_cc_report 12:26:18 INFO - PROCESS | 4540 | _x_x_mozilla_cycle_collect,1138 12:26:18 INFO - PROCESS | 4540 | __end_cc_report 12:26:18 INFO - PROCESS | 4540 | __startTimestamp1457641578126__endTimestamp 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | ------- Summary: start ------- 12:26:18 INFO - PROCESS | 4540 | Number of tests: 14 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.50 stddev:3.65 (3.2%) stddev-sans-first:3.87 12:26:18 INFO - PROCESS | 4540 | Values: 111.0 114.0 108.0 113.0 114.0 115.0 103.0 112.0 113.0 114.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:155.00 stddev:18.01 (11.6%) stddev-sans-first:19.10 12:26:18 INFO - PROCESS | 4540 | Values: 155.0 136.0 154.0 181.0 147.0 155.0 163.0 138.0 187.0 134.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.76 (1.7%) stddev-sans-first:2.76 12:26:18 INFO - PROCESS | 4540 | Values: 160.0 162.0 161.0 161.0 162.0 162.0 163.0 163.0 162.0 170.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#3] audio-fft Cycles:10 Average:85.00 Median:74.00 stddev:14.03 (19.0%) stddev-sans-first:14.41 12:26:18 INFO - PROCESS | 4540 | Values: 75.0 76.0 100.0 97.0 73.0 76.0 73.0 107.0 100.0 73.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:21.09 (22.4%) stddev-sans-first:21.88 12:26:18 INFO - PROCESS | 4540 | Values: 95.0 94.0 143.0 94.0 94.0 95.0 131.0 94.0 95.0 139.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:26:18 INFO - PROCESS | 4540 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 12:26:18 INFO - PROCESS | 4540 | Values: 145.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 12:26:18 INFO - PROCESS | 4540 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:2.96 (4.5%) stddev-sans-first:3.14 12:26:18 INFO - PROCESS | 4540 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 65.0 74.0 64.0 63.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:70.00 stddev:2.85 (4.1%) stddev-sans-first:3.00 12:26:18 INFO - PROCESS | 4540 | Values: 70.0 69.0 70.0 70.0 78.0 69.0 69.0 73.0 72.0 69.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:3.46 (4.1%) stddev-sans-first:3.61 12:26:18 INFO - PROCESS | 4540 | Values: 84.0 85.0 85.0 83.0 94.0 84.0 85.0 90.0 84.0 84.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.50 stddev:3.97 (3.1%) stddev-sans-first:4.15 12:26:18 INFO - PROCESS | 4540 | Values: 123.0 129.0 120.0 122.0 125.0 123.0 130.0 120.0 130.0 128.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:148.50 stddev:5.43 (3.7%) stddev-sans-first:5.46 12:26:18 INFO - PROCESS | 4540 | Values: 142.0 140.0 155.0 148.0 149.0 138.0 148.0 147.0 149.0 153.0 12:26:18 INFO - PROCESS | 4540 | 12:26:18 INFO - PROCESS | 4540 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 12:26:18 INFO - PROCESS | 4540 | Values: 71.0 72.0 72.0 71.0 70.0 70.0 69.0 70.0 71.0 70.0 12:26:18 INFO - PROCESS | 4540 | -------- Summary: end -------- 12:26:18 INFO - PROCESS | 4540 | 12:26:19 INFO - TEST-INFO | 4540: exit 0 12:26:19 INFO - TEST-OK | kraken | took 62313ms 12:26:19 INFO - SUITE-END | took 1179s 12:26:19 INFO - Completed test suite (00:19:39) 12:26:19 INFO - javascript benchmark 12:26:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2557.9232623021303, 2627.5007748527764, 2638.9472210555778, 2651.0721247563356, 2665.067226470735, 4340.066885619591, 4448.933266001004, 4458.576435238655, 4464.7321160730335, 4480.686351955361, 4475.104979004204, 4506.97746511267, 4529.932051019237, 4557.68096233263, 4585.426821647294, 4067.4102255172984, 4116.053307739222, 4210.305299625558, 4247.447831781864, 4279.893002674927, 4024.3158663027357, 4183.602557757008, 4218.514870789868, 4234.30134027885, 4243.172581346638, 4071.75569465833, 4128.401381799622, 4135.193637240739, 4165.437665915093, 4165.58344165584, 4136.152088821815, 4139.482564679415, 4162.396452514368, 4166.604172603597, 4176.561461046576, 4021.296273152216, 4100.220958017997, 4119.8352065917325, 4140.585941405865, 4179.456670632799, 4393.055493069006, 4419.867403977886, 4486.730796152208, 4494.662900282492, 4516.774161291923, 4812.566868981773, 4836.51634836517, 4840.080384726891, 4841.975790121062, 4856.854294371139, 4636.397268355092, 4779.784909679072, 4839.491853355417, 4853.684510506806, 4886.1204983103025, 4497.820087196541, 4527.094581083797, 4529.909401811945, 4530.048689775152, 4531.116432295704, 4956.256561515729, 4957.6281778866005, 4959.504049595083, 4965.602751779849, 4972.825951091694, 4574.313852922089, 4623.329617205486, 4721.622270218374, 4724.598409135193, 4779.02030083832, 4790.0, 4794.808207671724, 4812.711237325701, 4814.975925120352, 4849.539293767087, 4768.546988036131, 4769.475357710649, 4770.61835053195, 4771.618270538349, 4819.638527110481, 4567.748773817472, 4718.245080787126, 4779.474257831635, 4814.807407703653, 4815.2054910940005, 3986.461827653288, 3994.8402063917697, 3998.8800335989968, 4016.136530645925, 4042.595740425934, 3461.705755010802, 3525.6121826599056, 3532.0, 3546.3971124908826, 3570.4822800693755, 4112.979435102805, 4113.794310284474, 4158.6465150462545, 4199.139176468817, 4199.811008504625, 4784.186688262934, 4790.760461976887, 4803.447603525569, 4810.903781924412, 4855.028994201174, 4073.89815254621, 4154.252234597741, 4161.126163505637, 4178.874633760992, 4189.622933935961, 4229.0, 4275.551067137968, 4277.3797799319545, 4303.182395344875, 4315.1585440838735, 4503.166914120898, 4516.367708520876, 4524.932126018047, 4570.063137056895, 4573.405457290664, 4696.671233013656, 4790.95209047919, 4793.664443489062, 4796.8081276748535, 4836.492168322417, 4516.209663308973, 4568.771561421982, 4573.611243044378, 4603.286490593963, 4607.838725644587, 4667.732950666856, 4706.0, 4709.858704238878, 4711.505291944297, 4749.382580264543, 4702.294655801657, 4758.452777930583, 4763.3807605011125, 4764.9047019058735, 4797.352357431702, 4657.6506761992305, 4670.766461676834, 4677.485476597503, 4679.742614156254, 4720.905581888274, 4679.578837904605, 4680.438347398334, 4681.648876334357, 4692.906141877212, 4710.152172608963, 4461.420015397977, 4515.887102822456, 4598.908021839477, 4606.0, 4606.907861842811, 4660.161170989254, 4673.532646735299, 4678.766061696833, 4698.271767875985, 4717.952820471752, 4534.931976020428, 4541.205289074464, 4541.43232095988, 4571.360009598726, 4576.4508259009135], "unit": "score", "name": "dojo.html", "value": 4410.120528582172}, {"lowerIsBetter": false, "replicates": [486.80284484783675, 491.2483899633562, 500.63453678814466, 544.8993034071176, 549.5548605629441, 24198.87900560497, 32882.83558582207, 33227.99999999997, 33228.33543329138, 33265.83367083167, 36614.084647883814, 37001.25997480055, 37053.444198336976, 37060.07349816256, 37107.81446092772, 6730.932690673104, 7577.962110189455, 7770.067591888953, 7781.338586220149, 9477.47873866937, 9665.710028699115, 9798.657047003357, 9810.803783924317, 9822.901770982306, 9825.754356141082, 10074.294799364048, 10193.082622563968, 10208.795824083514, 10218.080372766486, 10227.079562839343, 10003.699889003341, 10115.29192956497, 10117.392956422638, 10121.089101980784, 10127.544260508295, 9903.900960990442, 10071.949640251825, 10080.798384032352, 10082.19342452602, 10083.092521673012, 36629.63370366289, 36840.63159368399, 36903.81548092242, 36922.07694807625, 36925.0, 2851.158908122109, 2973.55396690496, 3165.635951865519, 3236.96763032369, 3699.5930447650735, 28391.57412638812, 28430.0, 28455.0, 29081.563776543368, 29198.708012920022, 3479.704225140866, 3485.9900697892313, 3508.8771892983877, 3564.0377098183344, 3636.654517820803, 223532.0, 224068.0, 224094.0, 225045.0, 225454.87272563696, 38027.429588556195, 54974.72512637491, 56037.15944260839, 56073.0, 56074.719626402424, 36307.458477906825, 36579.81710091486, 36606.63393366032, 36618.0, 36635.26729465396, 13053.086283960221, 13231.404586793617, 13234.867651323557, 13242.404091815892, 13251.536196233279, 9238.030006849318, 10540.578376864993, 10894.67315980522, 10901.563937442572, 10905.509252083675, 13027.0, 13069.934650326688, 13096.738065238642, 13101.541446049534, 13216.73566528664, 5394.649347792381, 5416.485433883775, 5449.918251226235, 5486.725663716798, 5510.393856675762, 758.6548120605222, 837.4556538250187, 837.9944067119359, 979.3389462113046, 1052.037385792007, 25853.353666158495, 27053.594196087073, 27292.590611140848, 27391.315217119733, 27530.587041194398, 903.7333986473875, 915.4095608332589, 947.5025611553851, 985.261054209343, 1031.1080915008463, 14029.508967186099, 14185.787213191605, 14303.254745472526, 14411.207383594003, 14448.349824257934, 249372.0, 253142.0, 253184.0, 254194.0, 254410.0, 45546.544534554894, 46411.0, 46419.53580464152, 46423.0, 46426.0, 964.3827950111934, 1122.5229277557169, 1165.1669056624555, 1211.7697637448857, 1224.0697070226513, 23826.642600361356, 24269.0, 25169.748302517473, 25773.226803195936, 27230.5915411265, 36304.818475908505, 46704.29943550917, 47589.0, 47623.047539049716, 47644.0, 246957.0, 247528.0, 249585.0, 249802.0, 249966.0, 34132.65867341394, 38223.80888095542, 38738.22523549457, 39104.2179156421, 39863.40204896871, 35020.47469287912, 42042.0, 42106.0, 42129.36805947975, 42887.0, 31484.527732083578, 33201.50197747084, 33861.66138338585, 33944.15139621529, 34047.808326708444, 33173.83413082919, 33245.50131748074, 33320.66679333176, 33709.32581348409, 33933.15167120743, 33544.1613959653, 33630.327393452484, 33661.49507757337, 35251.82374088113, 36199.63800361963, 26303.473930521664, 27060.34685317457, 28594.285142871595, 29313.85343073271, 30707.79165604583, 23965.405189221758, 24113.397165071012, 24197.637035444834, 24200.49354100633, 24379.0], "unit": "score", "name": "ext.html", "value": 16776.037659295976}, {"lowerIsBetter": false, "replicates": [324.21701590658563, 330.8759215294265, 333.37658578458286, 335.1370221679177, 338.25797144704785, 14527.926519058117, 15080.170590617512, 15591.84408155918, 16068.598285042879, 16535.83464165358, 11215.214934954536, 11775.116866235025, 12207.572734954278, 14714.705705885875, 15575.610609734762, 4717.29240613908, 4848.345473361086, 4875.414950205963, 4885.413750349963, 4885.487023862496, 4738.265568836836, 4746.5490778376, 4876.780544875489, 4894.902101957959, 5014.5457817232955, 4954.975225123887, 4969.70181789092, 4976.104301225778, 4986.75066246688, 4997.725125118117, 4897.216445368724, 4942.802287908479, 4953.133201689726, 4955.083309587738, 4956.826511072113, 4273.423087883127, 4407.338899165119, 4412.382266482695, 4416.028473735773, 4418.204723149832, 17943.282268709238, 18201.08994550267, 18564.350247741266, 18692.719609205873, 18776.061196940234, 1782.4296225207938, 1799.9460016199534, 1811.5652243461475, 1832.2854086906118, 1925.3261358524544, 12009.0, 12453.0, 12524.436400362005, 12831.294278814661, 12949.935250323782, 1731.6190438103722, 1738.4610770661009, 1778.4931294580983, 1779.3861117914298, 1785.3840425053336, 56764.43235567633, 57342.42657573454, 57371.713141434026, 57491.13763293512, 57871.710641446945, 8800.559972001374, 8842.955785221033, 8942.552872356357, 8973.461592304482, 9128.90871091294, 10911.290766100337, 10943.562257509611, 10963.177761667906, 10978.396188209725, 11085.83371249432, 7074.6816393262425, 7136.678849451787, 7156.427485801123, 7188.676509557083, 7230.493865429475, 7083.964580177169, 7153.141623005273, 7267.236940121317, 7284.6721897514735, 7300.4159667226495, 5461.781528738886, 5555.138953462219, 5559.27729395176, 5593.440655934455, 5644.3508996465935, 1630.2582325042076, 1647.5057482755126, 1654.073718717522, 1659.2450435052021, 1690.2562872336132, 843.9577122254011, 854.6752234150982, 870.629982257538, 879.2438502887512, 894.9707835988665, 15325.846741532665, 15417.845821541865, 15815.604609884846, 16016.75974860378, 16230.0, 815.9637260678904, 851.3614788908319, 877.6928075173638, 884.3014018925106, 911.2709832134266, 9047.547622618842, 9134.70382062699, 9243.90756092444, 9442.0, 9518.0, 217781.0, 220569.0, 361037.0, 361524.0, 367974.0, 50600.74699626478, 72723.63638181775, 72862.0, 74198.62900685462, 74862.0, 842.1914961636775, 871.4553404122423, 873.7946582553095, 875.8088998961407, 877.3069275272463, 13480.73038539204, 14132.78800818009, 14328.068675536057, 14355.354009069826, 14355.425782968565, 30499.847500762353, 31346.529802053443, 31428.0, 31467.0, 31825.6817431832, 42362.5763742371, 42560.78719606382, 42755.0, 42902.78548607237, 43737.0, 7169.426445884213, 7294.307040831112, 7366.189719130784, 7411.036565246699, 7484.513506622052, 10108.292419530562, 10971.945140274247, 11013.118950484102, 11179.888201117885, 11374.886251137714, 9297.907020929704, 9598.232141428809, 9666.371685840399, 9701.854472183064, 9726.416415015121, 9598.0, 9886.357386769838, 9917.702468925943, 9941.950290248502, 10062.547185376528, 9548.856767148638, 9616.423014619146, 9739.707808765748, 9764.170045546209, 10098.141657959155, 7192.029076074663, 7296.7810965671115, 7307.26927307265, 7307.3423391894985, 7442.292982166686, 7740.883886741591, 8772.56137193125, 9104.817903642022, 9456.574454149717, 10159.44123073238], "unit": "score", "name": "jquery.html", "value": 7650.801183108458}, {"lowerIsBetter": false, "replicates": [1279.0087682046408, 1349.6086135020848, 1353.9323033848304, 1484.3988184785167, 1748.5278974676837, 6555.868882622344, 7196.064511613489, 7321.194668586451, 7334.816629584263, 7338.0, 7197.784066478001, 7367.336939675428, 7368.078990126234, 7369.226231245722, 7371.299726525972, 1785.0628420079497, 1822.5079228608267, 1824.9908750456295, 2093.8743675379487, 2123.3205374280237, 2085.4369320283513, 2130.659094544873, 2131.07298325229, 2133.7332833395826, 2134.157007981846, 2073.9274125405614, 2076.615826072174, 2077.054940002303, 2077.1898959405844, 2095.6437405641, 2127.9787202127936, 2139.3047259640603, 2140.32579737383, 2140.7003019577273, 2140.7324084489437, 2032.5325175209637, 2080.4694802825184, 2084.3538503064096, 2085.35354040248, 2093.110428068065, 7419.332260096563, 7473.476856620039, 7477.5887326197035, 7481.7007319707145, 7487.9625601872185, 4188.246115699173, 4301.612854843048, 4303.505096913864, 4313.870583882489, 4320.503142138663, 2708.038646280562, 2782.5130602144545, 2811.7469427751603, 2827.9293017674518, 2832.603435519029, 871.1288711288711, 876.5617191404298, 881.8765372847806, 894.0165817600653, 920.0569416348229, 10118.696439106838, 10132.54403551842, 10134.847977280348, 10152.340097893613, 10159.23805714567, 3867.4972253607416, 3991.261616600938, 4058.228936502055, 4062.878113656595, 4075.042365044212, 8657.610407531676, 8720.781980450412, 8732.78168045804, 8735.25750311218, 8776.60505277264, 4237.131388065439, 4238.237117318912, 4248.808803603783, 4265.616094551443, 4266.0, 3429.794212347217, 3739.2147648993473, 3762.3792074307435, 3832.9616703833162, 3861.189150278417, 3288.1122097034145, 3337.4159522083537, 3369.309291595266, 3373.8313084345687, 3395.8132302723093, 1059.3114475590928, 1063.5320458998017, 1067.8771941226703, 1070.710908054821, 1074.9516271767789, 890.0387581412189, 891.3136884598823, 899.5906862377733, 907.2515174980535, 1042.4475028235047, 7136.750213742494, 7146.2496437874315, 7166.892496612555, 7169.749058782918, 7174.497785154989, 428.34890965732535, 429.69276966968766, 432.8831215571778, 1054.2936232724094, 1111.111111111108, 5435.2934118564335, 5457.536109430664, 5471.835844924659, 5525.806596769094, 5528.944710552923, 8333.583320833934, 8592.828143437097, 8649.351298652626, 8664.0, 8680.6527738891, 8379.0, 8411.285040771481, 8424.368172387096, 8448.408611397266, 8509.61706723199, 6964.582125072512, 7163.820904477326, 7239.782806515707, 7245.963770181115, 7253.165885923081, 6733.158355205599, 6737.090492783412, 6805.353491418307, 6810.523263371517, 6813.4208592270215, 8027.799305017421, 8131.9593402032615, 8220.424570280024, 8278.586070696561, 8319.750407487785, 8217.30152937007, 8426.368022398467, 8435.409521333448, 8494.74515764528, 8529.0, 5208.296879921162, 5628.296462942132, 5910.320313163869, 5955.40445955401, 6013.609115407485, 6873.5875847449315, 6884.070650462324, 6939.583624982517, 6943.548669336477, 6947.5831450113155, 6005.729742161526, 6168.599041062316, 6225.066240063846, 6265.718042688181, 6398.584092034003, 5974.910376344272, 6016.969915150396, 6039.698015099315, 6112.144299798121, 6133.141360209485, 6263.686815659108, 6330.873382532415, 6334.714937827901, 6350.587211831216, 6356.904646430215, 5841.474267315962, 5861.0, 5876.647401155944, 5883.058710606282, 5894.263217097863, 6031.520968533545, 6048.0625503047095, 6049.637021778707, 6062.060380641008, 6062.090686397076], "unit": "score", "name": "mootools.html", "value": 4077.326144176401}, {"lowerIsBetter": false, "replicates": [283.6213654770881, 297.27316710642475, 304.0938004745858, 307.75687207106387, 308.28324146359716, 5282.577393808496, 5344.946550534499, 5352.090144675405, 5372.194170874371, 5380.273663055491, 5268.710220937847, 5279.653688309476, 5282.366116066068, 5284.339457567804, 5296.126139187029, 3892.7275090743587, 4008.639222469977, 4126.66986641068, 4127.62851343379, 4131.876043718693, 4126.0510082681, 4126.5667104954, 4128.256913755523, 4128.256913755523, 4143.9171216575805, 3843.577206507282, 4092.1815636872598, 4094.877153685379, 4098.221337945795, 4101.8974525636795, 3971.225611005855, 4068.6541643960004, 4085.060436099684, 4085.0808568072243, 4091.0386059276047, 3577.3918433866306, 3580.982095089534, 3587.1749497615697, 3588.174719814457, 3590.694790942773, 5088.058709138784, 5092.465291144414, 5093.752030752452, 5100.923486147711, 5101.744912754348, 4691.507391723854, 4693.671442998992, 4694.882627934329, 4695.60087392572, 4702.788374523155, 5523.834284971457, 5526.032944234743, 5532.197831314437, 5533.197686335499, 5536.280283563111, 3802.277567262239, 3910.765354078736, 3914.0, 3916.0, 3920.2551515212017, 5694.060480020791, 5742.483176514133, 5760.481556659879, 5764.481196692318, 5781.942180578182, 4053.0, 4058.0869304406274, 4059.817308221137, 4061.3298805696727, 4061.9796901015307, 4114.670826333886, 4121.91756164875, 4122.361034039729, 4123.484564429446, 4124.298869192245, 4678.532146785362, 4679.27471241958, 4681.50844161365, 4690.460597031385, 4691.061787642485, 5582.106862901997, 5584.609077364546, 5585.413531579207, 5585.69278689676, 5586.190002449622, 1404.831420229579, 1431.5633731711719, 1452.1795185720034, 1454.4400405843614, 1457.4316016753476, 929.1962452478692, 981.47000619666, 985.5121714751101, 1005.8994100589882, 1006.6325791086201, 4803.375561177025, 4814.398200224972, 4817.855464336076, 4861.0, 4877.292792545061, 5726.570507211893, 5727.856803579861, 5728.255326807488, 5728.513076388554, 5737.483626473638, 4861.295112208781, 4862.367892174066, 4865.9756701216265, 4868.95131048692, 4879.170541008037, 3018.9698103019127, 3072.8770849165785, 3073.339232065117, 3074.508078707396, 3079.045495896279, 5390.353157621111, 5397.3523177218985, 5400.513953744182, 5409.26974858397, 5410.026195284887, 5725.141228815711, 5972.223610930551, 5991.041433370639, 5993.370696076936, 6006.069059295816, 5456.099743542271, 5465.754041068161, 5485.588580856452, 5487.4238204987905, 5489.313835770528, 5803.984302746918, 5813.563982701399, 5819.5344372450945, 5819.952408566499, 5820.447057529528, 5700.401457846866, 5711.600187986801, 5712.885742285214, 5717.42825717425, 5720.542356611378, 5343.382754004036, 5471.37079235893, 5474.835754927359, 5479.0, 5488.670679759227, 3847.249786291646, 3902.9414558781073, 3925.6270654287796, 3929.115948911472, 3935.6654684351006, 5750.453706897838, 5765.394633563583, 5769.173105178348, 5780.971095144498, 5785.363610002981, 5575.581831362745, 5578.30271216098, 5583.69289689071, 5589.413111623384, 5589.692566908859, 5570.86072848182, 5574.331080270394, 5574.637648552831, 5581.581381396492, 5583.888322233452, 5316.494932981361, 5467.753951072132, 5471.917921231265, 5474.5894057945015, 5479.178123281539, 5537.058700020925, 5615.803446879339, 5616.915746263891, 5617.045102332531, 5624.803131890364, 5370.892582148414, 5402.0, 5403.567714582745, 5403.891922161613, 5409.323834520685], "unit": "score", "name": "prototype.html", "value": 4181.632435072214}, {"lowerIsBetter": false, "replicates": [614.0635530815507, 632.7310892870529, 634.3561285295423, 709.9432045436365, 712.4442934511081, 11350.545978160873, 11449.026832719228, 11461.255018423797, 11478.426078696053, 11659.475323610437, 11130.38782866942, 11182.776344473126, 11201.383923884183, 11217.214794964355, 11234.606788762374, 598.9161517387569, 782.5109306683323, 801.6112185590014, 809.0938149272794, 810.2545657994659, 793.4128744728916, 798.1220657276978, 800.6437135474716, 801.0947629179049, 801.3629164813958, 822.7696245051366, 827.028241815867, 828.3456069704926, 829.1832544943226, 833.8999320081599, 638.7476946606112, 821.2813787935556, 833.6998680475024, 836.017679226912, 837.811492414208, 610.2920612089954, 612.7212118486123, 616.747133675191, 617.0466629058116, 617.0528239152924, 11903.821442678367, 11967.281963082243, 11968.521259149624, 12005.699857503545, 12017.63947081589, 11153.163512736577, 11584.710382240428, 11693.0, 12113.454894529767, 12222.633321000385, 9482.478463684494, 9518.476483793389, 9571.18644915183, 9603.423794572349, 9608.807823843485, 3191.5053166758958, 3200.5519227308196, 3242.0435971388497, 3272.132884785534, 3321.618013928381, 39891.60108398908, 40215.597844021475, 40351.39472907879, 40358.39462408066, 40517.79741101305, 9536.904630953602, 9684.176844968257, 9816.411015339103, 9957.402555846673, 10112.696619101438, 16813.243404046847, 16839.579010524834, 16939.49181524556, 16962.83037169637, 16986.320547177973, 6473.805785826433, 6497.090407342976, 6508.981147013632, 6548.574342667712, 6593.044008618724, 3560.6795388415167, 3616.294822509585, 3640.4175331946763, 3682.742208045465, 3729.4405839124347, 2717.4293398386562, 2729.3040274730215, 2750.4499100180046, 2766.363736340613, 2769.8753556090023, 452.2334642780456, 467.9321498382715, 486.13225392674616, 493.96048316134625, 496.74417674897455, 501.83941138835223, 521.9556337711338, 586.4399498479028, 592.8399332180287, 599.340725202274, 7472.701091956261, 7628.237176282439, 7636.951968793107, 7812.726554570563, 7890.289873911375, 582.9387914269025, 590.0912594604262, 598.6378241164033, 606.6451126091198, 609.9451049405575, 3507.8070706111407, 3522.454019626962, 3555.591107022674, 3571.62497937718, 3573.160307327776, 46266.53733462622, 47149.5285047152, 47450.76274618605, 47598.28602570964, 47730.76134619374, 43327.35008974868, 43411.34882976758, 43474.782626086664, 43795.781021095325, 44490.33264501035, 39247.41128883069, 39280.2143957125, 39400.80299598541, 40110.59889401068, 40679.0, 6797.524173307821, 6930.584164950119, 6938.548994315353, 7047.964760176166, 7102.467314951503, 30598.388032239676, 30737.38525229438, 31451.685483144876, 31605.52591711172, 32012.6798732019, 36047.098822529646, 36152.819235903655, 36488.27023459463, 39004.414933776585, 39085.804570976965, 9445.669401570913, 9564.187044101329, 10072.395656260647, 10102.39385636864, 10168.84746728785, 8517.490392879457, 10633.574657013633, 10805.135589153006, 11025.44872756343, 11117.555297787998, 9860.359076659994, 9947.900520994986, 10036.347637403545, 10696.83954740664, 11199.0, 9953.701388958343, 10053.49732513386, 10296.536655850654, 10570.8414373786, 10727.731806704895, 9852.458114803754, 9951.303408761607, 10894.61868834587, 10969.067629251604, 10982.780344392908, 8401.831963360577, 8570.871436928326, 8709.825803484022, 8796.032436432115, 8879.0, 8352.33181345503, 8741.125887411208, 9104.863427048467, 9208.171264585952, 9216.677416290398], "unit": "score", "name": "yui.html", "value": 5631.141827284561}], "name": "dromaeo_css", "value": 6154.625447201453}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 108.0, 113.0, 114.0, 115.0, 103.0, 112.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [155.0, 136.0, 154.0, 181.0, 147.0, 155.0, 163.0, 138.0, 187.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 155.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 161.0, 162.0, 162.0, 163.0, 163.0, 162.0, 170.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 100.0, 97.0, 73.0, 76.0, 73.0, 107.0, 100.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 143.0, 94.0, 94.0, 95.0, 131.0, 94.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 74.0, 64.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 70.0, 78.0, 69.0, 69.0, 73.0, 72.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.9}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 83.0, 94.0, 84.0, 85.0, 90.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [123.0, 129.0, 120.0, 122.0, 125.0, 123.0, 130.0, 120.0, 130.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [142.0, 140.0, 155.0, 148.0, 149.0, 138.0, 148.0, 147.0, 149.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 71.0, 70.0, 70.0, 69.0, 70.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1546.3}]} 12:26:19 INFO - Return code: 0 12:26:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:26:19 ERROR - # TBPL SUCCESS # 12:26:19 INFO - Running post-action listener: _resource_record_post_action 12:26:19 INFO - Running post-run listener: _resource_record_post_run 12:26:20 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522022912; Read time: 12; Write time: 513940 12:26:20 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233553920; Read time: 0; Write time: 331028 12:26:20 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288468992; Read time: 12; Write time: 182912 12:26:20 INFO - Running post-run listener: _upload_blobber_files 12:26:20 INFO - Blob upload gear active. 12:26:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:26:20 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 12:26:20 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'] 12:26:20 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 12:26:20 INFO - (blobuploader) - INFO - Open directory for files ... 12:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:21 INFO - (blobuploader) - INFO - Done attempting. 12:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:26:22 INFO - (blobuploader) - INFO - Done attempting. 12:26:22 INFO - (blobuploader) - INFO - Iteration through files over. 12:26:22 INFO - Return code: 0 12:26:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:26:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:26:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad6df48c74b6248ba059ec9df03f4f9aa1c62b7cf16b2a009fa848924fa49b4c6631b66e32c56c33ce1a9d613370f0da283aee67660807a9c300c7272555e536", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a52d33eb9b989cd2f0968e1e49c45c4c8c310cb9d2a230ce6b0b1825b793be68c0f37ebb573484388fe4be0c2cb9e752f531d361443c3b197b182f6e67bff77"} 12:26:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:26:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:26:22 INFO - Contents: 12:26:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ad6df48c74b6248ba059ec9df03f4f9aa1c62b7cf16b2a009fa848924fa49b4c6631b66e32c56c33ce1a9d613370f0da283aee67660807a9c300c7272555e536", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a52d33eb9b989cd2f0968e1e49c45c4c8c310cb9d2a230ce6b0b1825b793be68c0f37ebb573484388fe4be0c2cb9e752f531d361443c3b197b182f6e67bff77"} 12:26:22 INFO - Running post-run listener: copy_logs_to_upload_dir 12:26:22 INFO - Copying logs to upload dir... 12:26:22 INFO - mkdir: /builds/slave/test/build/upload/logs 12:26:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.077506 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-03-10 12:26:22.584494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 12:26:22.588075) ========= 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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 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/ad6df48c74b6248ba059ec9df03f4f9aa1c62b7cf16b2a009fa848924fa49b4c6631b66e32c56c33ce1a9d613370f0da283aee67660807a9c300c7272555e536", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a52d33eb9b989cd2f0968e1e49c45c4c8c310cb9d2a230ce6b0b1825b793be68c0f37ebb573484388fe4be0c2cb9e752f531d361443c3b197b182f6e67bff77"} build_url:https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/T4N3QfazRUOv1sDjPtrxgw/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/ad6df48c74b6248ba059ec9df03f4f9aa1c62b7cf16b2a009fa848924fa49b4c6631b66e32c56c33ce1a9d613370f0da283aee67660807a9c300c7272555e536", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0a52d33eb9b989cd2f0968e1e49c45c4c8c310cb9d2a230ce6b0b1825b793be68c0f37ebb573484388fe4be0c2cb9e752f531d361443c3b197b182f6e67bff77"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 12:26:22.665132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:26:22.665450) ========= 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=a0d2d2de893abaa8702a9954000001a7-1457638253.152255-948645037 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 12:26:22.729640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 12:26:22.729960) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 12:26:22.730236) ========= ========= Total master_lag: 0.35 =========