builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1458214125.94 results: success (0) buildid: 20160317033210 builduid: 03b1408ab5fe4918aa9918eed29473b2 revision: 1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:45.937911) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:45.938787) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:45.939744) ========= 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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006504 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:45.970468) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:45.970814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:45.986613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:45.987351) ========= 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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.048254) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.048662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.049206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.049630) ========= 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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 04:28:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-03-17 04:28:46 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.212405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.212753) ========= 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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013575 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.268804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.269195) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e --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 1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e --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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 04:28:47,100 truncating revision to first 12 chars 2016-03-17 04:28:47,100 Setting DEBUG logging. 2016-03-17 04:28:47,100 attempt 1/10 2016-03-17 04:28:47,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1c5926c2e71f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 04:28:47,387 unpacking tar archive at: fx-team-1c5926c2e71f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.847369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.847773) ========= echo 1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e'] 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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e program finished with exit code 0 elapsedTime=0.004219 script_repo_revision: '1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.898317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.898674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 04:28:46.911194) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-17 04:28:46.911502) ========= /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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:28:47 INFO - MultiFileLogger online at 20160317 04:28:47 in /builds/slave/test 04:28:47 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 04:28:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:28:47 INFO - {'append_to_log': False, 04:28:47 INFO - 'base_work_dir': '/builds/slave/test', 04:28:47 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:28:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:28:47 INFO - 'branch': 'Fx-Team-Non-PGO', 04:28:47 INFO - 'buildbot_json_path': 'buildprops.json', 04:28:47 INFO - 'config_files': ('talos/linux_config.py',), 04:28:47 INFO - 'default_actions': ('clobber', 04:28:47 INFO - 'read-buildbot-config', 04:28:47 INFO - 'download-and-extract', 04:28:47 INFO - 'populate-webroot', 04:28:47 INFO - 'create-virtualenv', 04:28:47 INFO - 'install', 04:28:47 INFO - 'run-tests'), 04:28:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:28:47 INFO - 'download_minidump_stackwalk': True, 04:28:47 INFO - 'download_symbols': 'ondemand', 04:28:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:28:47 INFO - 'tooltool.py': '/tools/tooltool.py', 04:28:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:28:47 INFO - '/tools/misc-python/virtualenv.py')}, 04:28:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:28:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:28:47 INFO - 'installer_path': 'installer.exe', 04:28:47 INFO - 'log_level': 'info', 04:28:47 INFO - 'log_name': 'talos', 04:28:47 INFO - 'log_to_console': True, 04:28:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:28:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:28:47 INFO - 'opt_config_files': (), 04:28:47 INFO - 'pip_index': False, 04:28:47 INFO - 'sps_profile': False, 04:28:47 INFO - 'sps_profile_interval': 0, 04:28:47 INFO - 'suite': 'dromaeojs', 04:28:47 INFO - 'system_bits': '32', 04:28:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:28:47 INFO - 'title': 'talos-linux64-ix-039', 04:28:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:28:47 INFO - 'use_talos_json': True, 04:28:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:28:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:28:47 INFO - 'work_dir': 'build'} 04:28:47 INFO - ##### 04:28:47 INFO - ##### Running clobber step. 04:28:47 INFO - ##### 04:28:47 INFO - Running pre-action listener: _resource_record_pre_action 04:28:47 INFO - Running main action method: clobber 04:28:47 INFO - rmtree: /builds/slave/test/build 04:28:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:28:48 INFO - Running post-action listener: _resource_record_post_action 04:28:48 INFO - ##### 04:28:48 INFO - ##### Running read-buildbot-config step. 04:28:48 INFO - ##### 04:28:48 INFO - Running pre-action listener: _resource_record_pre_action 04:28:48 INFO - Running main action method: read_buildbot_config 04:28:48 INFO - Using buildbot properties: 04:28:48 INFO - { 04:28:48 INFO - "project": "", 04:28:48 INFO - "product": "firefox", 04:28:48 INFO - "script_repo_revision": "production", 04:28:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:28:48 INFO - "repository": "", 04:28:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:28:48 INFO - "buildid": "20160317033210", 04:28:48 INFO - "pgo_build": "False", 04:28:48 INFO - "basedir": "/builds/slave/test", 04:28:48 INFO - "buildnumber": 1460, 04:28:48 INFO - "slavename": "talos-linux64-ix-039", 04:28:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:28:48 INFO - "platform": "ubuntu64_hw", 04:28:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:28:48 INFO - "branch": "fx-team", 04:28:48 INFO - "repo_path": "integration/fx-team", 04:28:48 INFO - "revision": "1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e", 04:28:48 INFO - "stage_platform": "linux64", 04:28:48 INFO - "builduid": "03b1408ab5fe4918aa9918eed29473b2", 04:28:48 INFO - "slavebuilddir": "test" 04:28:48 INFO - } 04:28:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:28:48 INFO - Running post-action listener: _resource_record_post_action 04:28:48 INFO - ##### 04:28:48 INFO - ##### Running download-and-extract step. 04:28:48 INFO - ##### 04:28:48 INFO - Running pre-action listener: _resource_record_pre_action 04:28:48 INFO - Running main action method: download_and_extract 04:28:48 INFO - mkdir: /builds/slave/test/build/tests 04:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:48 INFO - https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:28:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:28:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:28:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:48 INFO - Downloaded 1361 bytes. 04:28:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:28:48 INFO - Using the following test package requirements: 04:28:48 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:28:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:28:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:28:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'jsshell-linux-x86_64.zip'], 04:28:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:28:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:28:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:28:48 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:28:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:28:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:28:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:28:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:48 INFO - https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:28:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:28:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:28:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:50 INFO - Downloaded 22008941 bytes. 04:28:50 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'] 04:28:50 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 04:28:51 INFO - Return code: 0 04:28:51 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 04:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:51 INFO - https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:28:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:28:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:28:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:55 INFO - Downloaded 22008941 bytes. 04:28:55 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'] 04:28:55 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 04:28:56 INFO - Return code: 0 04:28: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')]} 04:28:56 INFO - https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:28:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:28:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:28:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:57 INFO - Downloaded 10846565 bytes. 04:28:57 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'] 04:28:57 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 04:28:57 INFO - Return code: 0 04:28:57 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')]} 04:28:57 INFO - https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:28:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:28:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:28:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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 04:28:59 INFO - Downloaded 54153121 bytes. 04:28:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:28:59 INFO - mkdir: /builds/slave/test/properties 04:28:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:28:59 INFO - Writing to file /builds/slave/test/properties/build_url 04:28:59 INFO - Contents: 04:28:59 INFO - build_url:https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:29:00 INFO - Running post-action listener: _resource_record_post_action 04:29:00 INFO - Running post-action listener: set_extra_try_arguments 04:29:00 INFO - ##### 04:29:00 INFO - ##### Running populate-webroot step. 04:29:00 INFO - ##### 04:29:00 INFO - Running pre-action listener: _resource_record_pre_action 04:29:00 INFO - Running main action method: populate_webroot 04:29:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:29:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:29:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:29:00 INFO - '--tppagecycles', 04:29:00 INFO - '7'], 04:29:00 INFO - 'tests': ['tsvgm']}}, 04:29:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:29:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:29:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:29:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:29:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:00 INFO - 'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:00 INFO - 'tests': ['damp', 'tps']}, 04:29:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:00 INFO - 'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['damp', 'tps']}, 04:29:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:29:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:29:00 INFO - 'other': {'tests': ['a11yr', 04:29:00 INFO - 'ts_paint', 04:29:00 INFO - 'tpaint', 04:29:00 INFO - 'sessionrestore', 04:29:00 INFO - 'sessionrestore_no_auto_restore', 04:29:00 INFO - 'tabpaint']}, 04:29:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['a11yr', 04:29:00 INFO - 'ts_paint', 04:29:00 INFO - 'tpaint', 04:29:00 INFO - 'sessionrestore', 04:29:00 INFO - 'sessionrestore_no_auto_restore', 04:29:00 INFO - 'tabpaint']}, 04:29:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['a11yr', 04:29:00 INFO - 'ts_paint', 04:29:00 INFO - 'tpaint', 04:29:00 INFO - 'sessionrestore', 04:29:00 INFO - 'sessionrestore_no_auto_restore', 04:29:00 INFO - 'tabpaint']}, 04:29:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['a11yr', 04:29:00 INFO - 'ts_paint', 04:29:00 INFO - 'tpaint', 04:29:00 INFO - 'sessionrestore', 04:29:00 INFO - 'sessionrestore_no_auto_restore', 04:29:00 INFO - 'tabpaint']}, 04:29:00 INFO - 'other_l64': {'tests': ['a11yr', 04:29:00 INFO - 'ts_paint', 04:29:00 INFO - 'tpaint', 04:29:00 INFO - 'sessionrestore', 04:29:00 INFO - 'sessionrestore_no_auto_restore', 04:29:00 INFO - 'tabpaint']}, 04:29:00 INFO - 'other_nol64': {'tests': ['a11yr', 04:29:00 INFO - 'ts_paint', 04:29:00 INFO - 'tpaint', 04:29:00 INFO - 'sessionrestore', 04:29:00 INFO - 'sessionrestore_no_auto_restore', 04:29:00 INFO - 'tabpaint']}, 04:29:00 INFO - 'svgr': {'tests': ['tsvgx', 04:29:00 INFO - 'tsvgr_opacity', 04:29:00 INFO - 'tart', 04:29:00 INFO - 'tscrollx', 04:29:00 INFO - 'cart']}, 04:29:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['tsvgx', 04:29:00 INFO - 'tsvgr_opacity', 04:29:00 INFO - 'tart', 04:29:00 INFO - 'tscrollx', 04:29:00 INFO - 'cart']}, 04:29:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:00 INFO - 'tests': ['tp5o']}, 04:29:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:00 INFO - 'talos_options': ['--e10s'], 04:29:00 INFO - 'tests': ['tp5o']}, 04:29:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:00 INFO - 'talos_options': ['--xperf_path', 04:29:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:00 INFO - 'tests': ['tp5n']}, 04:29:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:00 INFO - 'talos_options': ['--e10s', 04:29:00 INFO - '--xperf_path', 04:29:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:00 INFO - 'tests': ['tp5n']}}, 04:29:00 INFO - 'talos.zip': {'path': '', 04:29:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:29:00 INFO - Running post-action listener: _resource_record_post_action 04:29:00 INFO - ##### 04:29:00 INFO - ##### Running create-virtualenv step. 04:29:00 INFO - ##### 04:29:00 INFO - Running pre-action listener: _resource_record_pre_action 04:29:00 INFO - Running main action method: create_virtualenv 04:29:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:29:00 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 04:29:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:29:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:29:00 INFO - Using real prefix '/usr' 04:29:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:29:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:29:02 INFO - Installing pip.................done. 04:29:02 INFO - Return code: 0 04:29:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:29:02 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')]} 04:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:02 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')]} 04:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:02 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 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29:02 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 04:29:02 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 04:29:02 INFO - Using env: {'DISPLAY': ':0', 04:29:02 INFO - 'HOME': '/home/cltbld', 04:29:02 INFO - 'LANG': 'en_US.UTF-8', 04:29:02 INFO - 'LANGUAGE': 'en_US:en', 04:29:02 INFO - 'LOGNAME': 'cltbld', 04:29:02 INFO - 'MAIL': '/var/mail/cltbld', 04:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:02 INFO - 'MOZ_NO_REMOTE': '1', 04:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:02 INFO - 'NO_EM_RESTART': '1', 04:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:02 INFO - 'PWD': '/builds/slave/test', 04:29:02 INFO - 'SHELL': '/bin/bash', 04:29:02 INFO - 'SHLVL': '1', 04:29:02 INFO - 'TERM': 'linux', 04:29:02 INFO - 'TMOUT': '86400', 04:29:02 INFO - 'USER': 'cltbld', 04:29:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:02 INFO - '_': '/tools/buildbot/bin/python'} 04:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:03 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 04:29:03 INFO - Cleaning up... 04:29:03 INFO - Return code: 0 04:29:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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', '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 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:29: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 psutil>=0.7.1 04:29:03 INFO - Using env: {'DISPLAY': ':0', 04:29:03 INFO - 'HOME': '/home/cltbld', 04:29:03 INFO - 'LANG': 'en_US.UTF-8', 04:29:03 INFO - 'LANGUAGE': 'en_US:en', 04:29:03 INFO - 'LOGNAME': 'cltbld', 04:29:03 INFO - 'MAIL': '/var/mail/cltbld', 04:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:03 INFO - 'MOZ_NO_REMOTE': '1', 04:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:03 INFO - 'NO_EM_RESTART': '1', 04:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:03 INFO - 'PWD': '/builds/slave/test', 04:29:03 INFO - 'SHELL': '/bin/bash', 04:29:03 INFO - 'SHLVL': '1', 04:29:03 INFO - 'TERM': 'linux', 04:29:03 INFO - 'TMOUT': '86400', 04:29:03 INFO - 'USER': 'cltbld', 04:29:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:03 INFO - '_': '/tools/buildbot/bin/python'} 04:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:03 INFO - Downloading/unpacking psutil>=0.7.1 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:29:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:05 INFO - Installing collected packages: psutil 04:29:05 INFO - Running setup.py install for psutil 04:29:05 INFO - building 'psutil._psutil_linux' extension 04:29:05 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 04:29:05 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 04:29:05 INFO - building 'psutil._psutil_posix' extension 04:29:05 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 04:29:05 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 04:29:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:05 INFO - Successfully installed psutil 04:29:05 INFO - Cleaning up... 04:29:05 INFO - Return code: 0 04:29:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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', '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 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:29: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 mozsystemmonitor==0.0.0 04:29:05 INFO - Using env: {'DISPLAY': ':0', 04:29:05 INFO - 'HOME': '/home/cltbld', 04:29:05 INFO - 'LANG': 'en_US.UTF-8', 04:29:05 INFO - 'LANGUAGE': 'en_US:en', 04:29:05 INFO - 'LOGNAME': 'cltbld', 04:29:05 INFO - 'MAIL': '/var/mail/cltbld', 04:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:05 INFO - 'MOZ_NO_REMOTE': '1', 04:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:05 INFO - 'NO_EM_RESTART': '1', 04:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:05 INFO - 'PWD': '/builds/slave/test', 04:29:05 INFO - 'SHELL': '/bin/bash', 04:29:05 INFO - 'SHLVL': '1', 04:29:05 INFO - 'TERM': 'linux', 04:29:05 INFO - 'TMOUT': '86400', 04:29:05 INFO - 'USER': 'cltbld', 04:29:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:05 INFO - '_': '/tools/buildbot/bin/python'} 04:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:29:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:29:07 INFO - Installing collected packages: mozsystemmonitor 04:29:07 INFO - Running setup.py install for mozsystemmonitor 04:29:08 INFO - Successfully installed mozsystemmonitor 04:29:08 INFO - Cleaning up... 04:29:08 INFO - Return code: 0 04:29:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:29:08 INFO - Using env: {'DISPLAY': ':0', 04:29:08 INFO - 'HOME': '/home/cltbld', 04:29:08 INFO - 'LANG': 'en_US.UTF-8', 04:29:08 INFO - 'LANGUAGE': 'en_US:en', 04:29:08 INFO - 'LOGNAME': 'cltbld', 04:29:08 INFO - 'MAIL': '/var/mail/cltbld', 04:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:08 INFO - 'MOZ_NO_REMOTE': '1', 04:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:08 INFO - 'NO_EM_RESTART': '1', 04:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:08 INFO - 'PWD': '/builds/slave/test', 04:29:08 INFO - 'SHELL': '/bin/bash', 04:29:08 INFO - 'SHLVL': '1', 04:29:08 INFO - 'TERM': 'linux', 04:29:08 INFO - 'TMOUT': '86400', 04:29:08 INFO - 'USER': 'cltbld', 04:29:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:08 INFO - '_': '/tools/buildbot/bin/python'} 04:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:29:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:29:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:10 INFO - Downloading docopt-0.6.1.tar.gz 04:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:29:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:29:10 INFO - Running setup.py install for blobuploader 04:29:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:29:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:29:10 INFO - Running setup.py install for requests 04:29:11 INFO - Running setup.py install for docopt 04:29:11 INFO - Successfully installed blobuploader requests docopt 04:29:11 INFO - Cleaning up... 04:29:11 INFO - Return code: 0 04:29:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:11 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')]} 04:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:11 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')]} 04:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:11 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 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29:11 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 04:29:11 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 04:29:11 INFO - Using env: {'DISPLAY': ':0', 04:29:11 INFO - 'HOME': '/home/cltbld', 04:29:11 INFO - 'LANG': 'en_US.UTF-8', 04:29:11 INFO - 'LANGUAGE': 'en_US:en', 04:29:11 INFO - 'LOGNAME': 'cltbld', 04:29:11 INFO - 'MAIL': '/var/mail/cltbld', 04:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:11 INFO - 'MOZ_NO_REMOTE': '1', 04:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:11 INFO - 'NO_EM_RESTART': '1', 04:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:11 INFO - 'PWD': '/builds/slave/test', 04:29:11 INFO - 'SHELL': '/bin/bash', 04:29:11 INFO - 'SHLVL': '1', 04:29:11 INFO - 'TERM': 'linux', 04:29:11 INFO - 'TMOUT': '86400', 04:29:11 INFO - 'USER': 'cltbld', 04:29:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:11 INFO - '_': '/tools/buildbot/bin/python'} 04:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:11 INFO - Running setup.py (path:/tmp/pip-_4SPFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:11 INFO - Running setup.py (path:/tmp/pip-i55QBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:11 INFO - Running setup.py (path:/tmp/pip-xKYuwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:11 INFO - Running setup.py (path:/tmp/pip-lcPyLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:11 INFO - Running setup.py (path:/tmp/pip-uL1Vk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:12 INFO - Running setup.py (path:/tmp/pip-df6ufp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:12 INFO - Running setup.py (path:/tmp/pip-PdEoTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:12 INFO - Running setup.py (path:/tmp/pip-n0kRo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:12 INFO - Running setup.py (path:/tmp/pip-Aga03a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:12 INFO - Running setup.py (path:/tmp/pip-deWtGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:12 INFO - Running setup.py (path:/tmp/pip-Qj6Hxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:12 INFO - Running setup.py (path:/tmp/pip-a6imr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:12 INFO - Running setup.py (path:/tmp/pip-AupCca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:12 INFO - Running setup.py (path:/tmp/pip-8dyU63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:12 INFO - Running setup.py (path:/tmp/pip-tKdSut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:12 INFO - Running setup.py (path:/tmp/pip-p1D9Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:12 INFO - Running setup.py (path:/tmp/pip-e9aAGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:29:12 INFO - Running setup.py install for manifestparser 04:29:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:29:12 INFO - Running setup.py install for mozcrash 04:29:13 INFO - Running setup.py install for mozdebug 04:29:13 INFO - Running setup.py install for mozdevice 04:29:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Running setup.py install for mozfile 04:29:13 INFO - Running setup.py install for mozhttpd 04:29:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Running setup.py install for mozinfo 04:29:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Running setup.py install for mozInstall 04:29:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Running setup.py install for mozleak 04:29:13 INFO - Running setup.py install for mozlog 04:29:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:29:13 INFO - Running setup.py install for moznetwork 04:29:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:29:14 INFO - Running setup.py install for mozprocess 04:29:14 INFO - Running setup.py install for mozprofile 04:29:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:29:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:29:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:29:14 INFO - Running setup.py install for mozrunner 04:29:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:29:14 INFO - Running setup.py install for mozscreenshot 04:29:14 INFO - Running setup.py install for moztest 04:29:14 INFO - Running setup.py install for mozversion 04:29:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:29:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:29:14 INFO - Cleaning up... 04:29:14 INFO - Return code: 0 04:29:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:14 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 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29:14 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 04:29:14 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 04:29:14 INFO - Using env: {'DISPLAY': ':0', 04:29:14 INFO - 'HOME': '/home/cltbld', 04:29:14 INFO - 'LANG': 'en_US.UTF-8', 04:29:14 INFO - 'LANGUAGE': 'en_US:en', 04:29:14 INFO - 'LOGNAME': 'cltbld', 04:29:14 INFO - 'MAIL': '/var/mail/cltbld', 04:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:14 INFO - 'MOZ_NO_REMOTE': '1', 04:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:14 INFO - 'NO_EM_RESTART': '1', 04:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:14 INFO - 'PWD': '/builds/slave/test', 04:29:14 INFO - 'SHELL': '/bin/bash', 04:29:14 INFO - 'SHLVL': '1', 04:29:14 INFO - 'TERM': 'linux', 04:29:14 INFO - 'TMOUT': '86400', 04:29:14 INFO - 'USER': 'cltbld', 04:29:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:14 INFO - '_': '/tools/buildbot/bin/python'} 04:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:14 INFO - Running setup.py (path:/tmp/pip-gj_5eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:14 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)) 04:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:14 INFO - Running setup.py (path:/tmp/pip-h9NcBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:15 INFO - Running setup.py (path:/tmp/pip-Vt7q1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:15 INFO - Running setup.py (path:/tmp/pip-64zqVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:15 INFO - Running setup.py (path:/tmp/pip-HP9gwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:15 INFO - Running setup.py (path:/tmp/pip-9AgwZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:15 INFO - Running setup.py (path:/tmp/pip-CEJDR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:15 INFO - Running setup.py (path:/tmp/pip-o5Bv3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:15 INFO - Running setup.py (path:/tmp/pip-PKx0kZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:15 INFO - Running setup.py (path:/tmp/pip-rD7ySZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:15 INFO - Running setup.py (path:/tmp/pip-ZnUZEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:15 INFO - Running setup.py (path:/tmp/pip-RSlZFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:15 INFO - Running setup.py (path:/tmp/pip-PXIN6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:15 INFO - Running setup.py (path:/tmp/pip-HZk5a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:15 INFO - Running setup.py (path:/tmp/pip-CjSz9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:15 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)) 04:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:15 INFO - Running setup.py (path:/tmp/pip-MaDpS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:16 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)) 04:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:16 INFO - Running setup.py (path:/tmp/pip-VsV5bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:16 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)) 04:29:16 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)) 04:29:16 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)) 04:29:16 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)) 04:29:16 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)) 04:29:16 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)) 04:29:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:17 INFO - Downloading blessings-1.6.tar.gz 04:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:29:18 INFO - Installing collected packages: blessings 04:29:18 INFO - Running setup.py install for blessings 04:29:18 INFO - Successfully installed blessings 04:29:18 INFO - Cleaning up... 04:29:18 INFO - Return code: 0 04:29:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:29:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:18 INFO - Reading from file tmpfile_stdout 04:29:18 INFO - Current package versions: 04:29:18 INFO - argparse == 1.2.1 04:29:18 INFO - blessings == 1.6 04:29:18 INFO - blobuploader == 1.2.4 04:29:18 INFO - docopt == 0.6.1 04:29:18 INFO - manifestparser == 1.1 04:29:18 INFO - mozInstall == 1.12 04:29:18 INFO - mozcrash == 0.17 04:29:18 INFO - mozdebug == 0.1 04:29:18 INFO - mozdevice == 0.48 04:29:18 INFO - mozfile == 1.2 04:29:18 INFO - mozhttpd == 0.7 04:29:18 INFO - mozinfo == 0.9 04:29:18 INFO - mozleak == 0.1 04:29:18 INFO - mozlog == 3.1 04:29:18 INFO - moznetwork == 0.27 04:29:18 INFO - mozprocess == 0.22 04:29:18 INFO - mozprofile == 0.28 04:29:18 INFO - mozrunner == 6.11 04:29:18 INFO - mozscreenshot == 0.1 04:29:18 INFO - mozsystemmonitor == 0.0 04:29:18 INFO - moztest == 0.7 04:29:18 INFO - mozversion == 1.4 04:29:18 INFO - psutil == 3.1.1 04:29:18 INFO - requests == 1.2.3 04:29:18 INFO - wsgiref == 0.1.2 04:29:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:18 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 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29:18 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 04:29:18 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 04:29:18 INFO - Using env: {'DISPLAY': ':0', 04:29:18 INFO - 'HOME': '/home/cltbld', 04:29:18 INFO - 'LANG': 'en_US.UTF-8', 04:29:18 INFO - 'LANGUAGE': 'en_US:en', 04:29:18 INFO - 'LOGNAME': 'cltbld', 04:29:18 INFO - 'MAIL': '/var/mail/cltbld', 04:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:18 INFO - 'MOZ_NO_REMOTE': '1', 04:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:18 INFO - 'NO_EM_RESTART': '1', 04:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:18 INFO - 'PWD': '/builds/slave/test', 04:29:18 INFO - 'SHELL': '/bin/bash', 04:29:18 INFO - 'SHLVL': '1', 04:29:18 INFO - 'TERM': 'linux', 04:29:18 INFO - 'TMOUT': '86400', 04:29:18 INFO - 'USER': 'cltbld', 04:29:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:18 INFO - '_': '/tools/buildbot/bin/python'} 04:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 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)) 04:29:18 INFO - Cleaning up... 04:29:18 INFO - Return code: 0 04:29:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29: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', 'jsonschema'] in /builds/slave/test/build 04:29: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 jsonschema 04:29:18 INFO - Using env: {'DISPLAY': ':0', 04:29:18 INFO - 'HOME': '/home/cltbld', 04:29:18 INFO - 'LANG': 'en_US.UTF-8', 04:29:18 INFO - 'LANGUAGE': 'en_US:en', 04:29:18 INFO - 'LOGNAME': 'cltbld', 04:29:18 INFO - 'MAIL': '/var/mail/cltbld', 04:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:18 INFO - 'MOZ_NO_REMOTE': '1', 04:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:18 INFO - 'NO_EM_RESTART': '1', 04:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:18 INFO - 'PWD': '/builds/slave/test', 04:29:18 INFO - 'SHELL': '/bin/bash', 04:29:18 INFO - 'SHLVL': '1', 04:29:18 INFO - 'TERM': 'linux', 04:29:18 INFO - 'TMOUT': '86400', 04:29:18 INFO - 'USER': 'cltbld', 04:29:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:18 INFO - '_': '/tools/buildbot/bin/python'} 04:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:18 INFO - Downloading/unpacking jsonschema 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:29:20 INFO - Downloading/unpacking functools32 (from jsonschema) 04:29:20 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 04:29:20 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 04:29:20 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 04:29:20 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 04:29:20 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 04:29:20 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 04:29:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:29:21 INFO - warning: no files found matching '*.txt' 04:29:21 INFO - no previously-included directories found matching 'build' 04:29:21 INFO - no previously-included directories found matching 'dist' 04:29:21 INFO - no previously-included directories found matching '.git*' 04:29:21 INFO - Installing collected packages: jsonschema, functools32 04:29:21 INFO - Running setup.py install for functools32 04:29:21 INFO - warning: no files found matching '*.txt' 04:29:21 INFO - no previously-included directories found matching 'build' 04:29:21 INFO - no previously-included directories found matching 'dist' 04:29:21 INFO - no previously-included directories found matching '.git*' 04:29:21 INFO - Successfully installed jsonschema functools32 04:29:21 INFO - Cleaning up... 04:29:21 INFO - Return code: 0 04:29:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:29:21 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')]} 04:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:21 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')]} 04:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:21 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 0x7f5101292f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', '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 04:29:21 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 04:29:21 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 04:29:21 INFO - Using env: {'DISPLAY': ':0', 04:29:21 INFO - 'HOME': '/home/cltbld', 04:29:21 INFO - 'LANG': 'en_US.UTF-8', 04:29:21 INFO - 'LANGUAGE': 'en_US:en', 04:29:21 INFO - 'LOGNAME': 'cltbld', 04:29:21 INFO - 'MAIL': '/var/mail/cltbld', 04:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:21 INFO - 'MOZ_NO_REMOTE': '1', 04:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:21 INFO - 'NO_EM_RESTART': '1', 04:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:21 INFO - 'PWD': '/builds/slave/test', 04:29:21 INFO - 'SHELL': '/bin/bash', 04:29:21 INFO - 'SHLVL': '1', 04:29:21 INFO - 'TERM': 'linux', 04:29:21 INFO - 'TMOUT': '86400', 04:29:21 INFO - 'USER': 'cltbld', 04:29:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:21 INFO - '_': '/tools/buildbot/bin/python'} 04:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:21 INFO - Downloading/unpacking flake8 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:29:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:29:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 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 04:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:29:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:29:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:29:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:29:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:29:24 INFO - no previously-included directories found matching 'docs/_build' 04:29:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:29:24 INFO - Running setup.py install for pep8 04:29:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:29:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:29:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:29:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:29:24 INFO - no previously-included directories found matching 'docs/_build' 04:29:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:29:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:29:24 INFO - Cleaning up... 04:29:24 INFO - Return code: 0 04:29:24 INFO - Running post-action listener: _resource_record_post_action 04:29:24 INFO - Running post-action listener: _start_resource_monitoring 04:29:24 INFO - Starting resource monitoring. 04:29:24 INFO - ##### 04:29:24 INFO - ##### Running install step. 04:29:24 INFO - ##### 04:29:24 INFO - Running pre-action listener: _resource_record_pre_action 04:29:24 INFO - Running main action method: install 04:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:24 INFO - Reading from file tmpfile_stdout 04:29:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:29:24 INFO - Reading from file tmpfile_stdout 04:29:24 INFO - Output received: 04:29:24 INFO - Usage: mozinstall [options] installer 04:29:24 INFO - Options: 04:29:24 INFO - -h, --help show this help message and exit 04:29:24 INFO - -d DEST, --destination=DEST 04:29:24 INFO - Directory to install application into. [default: 04:29:24 INFO - "/builds/slave/test"] 04:29:24 INFO - --app=APP Application being installed. [default: firefox] 04:29:24 INFO - mkdir: /builds/slave/test/build/application 04:29:24 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'] 04:29:24 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 04:29:40 INFO - Reading from file tmpfile_stdout 04:29:40 INFO - Output received: 04:29:40 INFO - /builds/slave/test/build/application/firefox/firefox 04:29:40 INFO - Running post-action listener: _resource_record_post_action 04:29:40 INFO - ##### 04:29:40 INFO - ##### Running run-tests step. 04:29:40 INFO - ##### 04:29:40 INFO - Running pre-action listener: _resource_record_pre_action 04:29:40 INFO - Running main action method: run_tests 04:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:29:40 INFO - Python 2.7.3 04:29:40 INFO - Return code: 0 04:29:40 INFO - grabbing minidump binary from tooltool 04:29: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')]} 04:29:40 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 0x2691410>, '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 0x2692310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26927a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:29:40 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 04:29:40 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 04:29:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:29:40 INFO - Return code: 0 04:29:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:29:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:29:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:29:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:29:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:29:41 INFO - Return code: 0 04:29:41 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/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 04:29:41 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/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 04:29:41 INFO - Using env: {'DISPLAY': ':0', 04:29:41 INFO - 'HOME': '/home/cltbld', 04:29:41 INFO - 'LANG': 'en_US.UTF-8', 04:29:41 INFO - 'LANGUAGE': 'en_US:en', 04:29:41 INFO - 'LOGNAME': 'cltbld', 04:29:41 INFO - 'MAIL': '/var/mail/cltbld', 04:29:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:29:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:41 INFO - 'MOZ_NO_REMOTE': '1', 04:29:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:41 INFO - 'NO_EM_RESTART': '1', 04:29:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:41 INFO - 'PWD': '/builds/slave/test', 04:29:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:29:41 INFO - 'SHELL': '/bin/bash', 04:29:41 INFO - 'SHLVL': '1', 04:29:41 INFO - 'TERM': 'linux', 04:29:41 INFO - 'TMOUT': '86400', 04:29:41 INFO - 'USER': 'cltbld', 04:29:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595', 04:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:41 INFO - '_': '/tools/buildbot/bin/python'} 04:29:41 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/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 04:29:41 INFO - mozversion application_buildid: 20160317033210 04:29:41 INFO - mozversion application_changeset: 1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e 04:29:41 INFO - mozversion application_display_name: Nightly 04:29:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:29:41 INFO - mozversion application_name: Firefox 04:29:41 INFO - mozversion application_remotingname: firefox 04:29:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:29:41 INFO - mozversion application_vendor: Mozilla 04:29:41 INFO - mozversion application_version: 48.0a1 04:29:41 INFO - mozversion platform_buildid: 20160317033210 04:29:41 INFO - mozversion platform_changeset: 1c5926c2e71ffcd60aa848ef4fb32d7b8a9f1b4e 04:29:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:29:41 INFO - mozversion platform_version: 48.0a1 04:29:41 INFO - using testdate: 1458214181 04:29:41 INFO - actual date: 1458214181 04:29:41 INFO - starting webserver on 'localhost:40130' 04:29:41 INFO - SUITE-START | Running 2 tests 04:29:41 INFO - TEST-START | dromaeo_css 04:29:41 INFO - operating with platform_type : linux_ 04:29:41 INFO - Initialising browser for dromaeo_css test... 04:29:41 INFO - TEST-INFO | started process 16455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPM47_2/profile http://localhost:40130/getInfo.html) 04:29:46 INFO - PROCESS | 16455 | __metrics Screen width/height:1600/1200 04:29:46 INFO - PROCESS | 16455 | colorDepth:24 04:29:46 INFO - PROCESS | 16455 | Browser inner width/height: 1024/697 04:29:46 INFO - PROCESS | 16455 | __metrics 04:29:46 ERROR - PROCESS | 16455 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:29:47 INFO - TEST-INFO | 16455: exit 0 04:29:47 INFO - Browser initialized. 04:29:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:29:47 INFO - TEST-INFO | started process 16549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPM47_2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:59 INFO - PROCESS | 16549 | RSS: Main: 154558464 04:29:59 INFO - PROCESS | 16549 | 04:30:50 INFO - PROCESS | 16549 | 1458214250768 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] 04:33:02 INFO - PROCESS | 16549 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40130/tests/dromaeo/cssquery-ext.html) 04:33:03 INFO - PROCESS | 16549 | RSS: Main: 245526528 04:33:03 INFO - PROCESS | 16549 | 04:36:05 INFO - PROCESS | 16549 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-ext.html (next: http://localhost:40130/tests/dromaeo/cssquery-jquery.html) 04:36:05 INFO - PROCESS | 16549 | RSS: Main: 233889792 04:36:05 INFO - PROCESS | 16549 | 04:39:07 INFO - PROCESS | 16549 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40130/tests/dromaeo/cssquery-mootools.html) 04:39:08 INFO - PROCESS | 16549 | RSS: Main: 230133760 04:39:08 INFO - PROCESS | 16549 | 04:42:10 INFO - PROCESS | 16549 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40130/tests/dromaeo/cssquery-prototype.html) 04:42:10 INFO - PROCESS | 16549 | RSS: Main: 209977344 04:42:10 INFO - PROCESS | 16549 | 04:45:13 INFO - PROCESS | 16549 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40130/tests/dromaeo/cssquery-yui.html) 04:45:14 INFO - PROCESS | 16549 | RSS: Main: 203808768 04:45:14 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | Cycle 1(1): loaded http://localhost:40130/tests/dromaeo/cssquery-yui.html (next: http://localhost:40130/tests/dromaeo/cssquery-dojo.html) 04:48:16 INFO - PROCESS | 16549 | RSS: Main: 262017024 04:48:16 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | __start_tp_report 04:48:16 INFO - PROCESS | 16549 | _x_x_mozilla_page_load 04:48:16 INFO - PROCESS | 16549 | _x_x_mozilla_page_load_details 04:48:16 INFO - PROCESS | 16549 | |i|pagename|runs| 04:48:16 INFO - PROCESS | 16549 | |0;dojo.html;2629.2900916752474;2688.448867982064;2698.082651898354;2701.1626395817284;2720.6871209810865;4638.582527572517;4695.084458530588;4708.058388322336;4723.669343145977;4742.383490146276;4686.46105697844;4724;4752.59602933751;4752.762361881901;4827.227643577028;4312.094460163369;4312.396264522961;4339.761313127777;4372.584604462571;4434.401355816955;4289.656827453812;4346.9347959780625;4372.956270437287;4406.162829062484;4430.55694430556;4314.309710446313;4333.783310834478;4347.108842687241;4408.184485870092;4432.512423633398;4342.1532801103795;4350.32569951658;4357.738535687838;4380.08018316154;4400.383946247528;4236.639885609727;4340.6093451589195;4348.173846969065;4356.346548017791;4387.890302742425;4524.11779702958;4582.725036497787;4619.307103934403;4638.397008388922;4649.814007439699;5054.014467178901;5092.567131793802;5099.235114732783;5144.356955380577;5154.561862241714;4925.704457732511;5038.748062596892;5108.182690769459;5117.8464646060675;5141.15170996785;4748.762561871893;4768.642351823627;4773.427188737373;4789.664723469358;4819.9999999999645;5216.400113986864;5232.450592687789;5233;5234.528892399626;5277.604179686539;4849.321095046696;4952.405711314594;5008.273800298936;5016.924746128811;5078.492150784966;5046.924296135561;5059.342285502935;5067.670601410897;5072.4673909239;5103.311053007871;5012.548870601663;5017.623678224148;5021.949780502148;5027.145385284511;5070.315507406527;4865;4942.604591632733;5021.171506701427;5052.469490703496;5064.797408103708;4266.65866730667;4272.273713468718;4280.828766849291;4283.892902677458;4332.848350307724;3770.5852356240794;3771.73597848148;3771.8114094295174;3779.1874746929543;3798.0504873781556;4323.48118225815;4340.544242854518;4393.780310984502;4407.405000324915;4416.447944006999;5087.618428617869;5099.77051032697;5105.744712764347;5108.438071812097;5165.225216217522;4386.868393948187;4398.516163222043;4401.471823381215;4406.33904914259;4438.334249862546;4454.020115574568;4526;4584.701994370355;4618.515055919147;4639.652026098056;4810.374651295309;4820.855374338776;4830.154722923545;4840.394950631171;4893.143699852582;4954.256861470808;5083.212102124176;5098.898022039612;5101.234814777813;5151.613628977917;4797.064572408347;4809.422869255712;4828.589569886599;4859.805607775791;4875.853724388274;4978.5270399312;5017.397912250553;5023.34696489454;5028.145215313332;5067.77195026232;4938.703677779345;5064.493550645054;5091.159958606789;5108.948910510847;5164.04465173944;4882.194437917704;4905.3623029006;4912.950870491392;4914.238293064581;4955.331030310862;4899.583535399531;4904.460509343898;4906.965256051455;4912.533309335608;4954.529319714621;4753.977894752645;4807.7836497357;4839.806407743651;4895.363602731622;4929.186684197068;4954.083494553519;4977.900441991067;4984.4517103117905;4996.525330093636;5039.924401134059;4844.636652251025;4865.756712164449;4868.221084626584;4868.440129385166;4920.45874953762 04:48:16 INFO - PROCESS | 16549 | |1;ext.html;538.6902531044648;539.7220431477792;543.2991441041057;563.9904570818235;574.5547200919287;26803.329916752067;27229.591556126674;27238.45523089542;27248.31879203016;27269.318267043334;29571.704282957166;34661;35068;35113.824430877874;35227.53407261493;7741.109772376164;7926.167752386003;7928.603569821515;7931.405144614148;7934.960325198366;7836;7951.642176102089;7965.243301886311;7970.282674559288;7975.162607926171;7964.522128672269;8016.919830801705;8023.839523209533;8026.719064832732;8034.678612855508;7913.089994650602;7978.082520510099;7982.1219665837;7988.041435027805;7990.480618759762;7854.921450785476;7996;7997.160298168725;7997.720079797237;8006.719764808262;39611;39628.20743585141;39934;40014.39978400326;40073.59926400757;2905.375344300964;2978.704263645321;3115.4703700370765;3256.2022304535303;3377.7973321600784;29443.70556294431;29745.405091898258;29773.255668608243;29944;30440.238994025105;3269.182704323919;3371.7471189660873;3398.269372084989;3411.232472693649;3424.0412684448393;184992;185703;185782.99999999866;186193;186533;43710.56289437129;58505.41494585085;58817.70591147017;58826;58917.410825891195;42441.575584243765;42671.35992960108;42733.78633106877;42744.57255427468;42761.79953906666;13916.165030098227;14120.152790832582;14143.36354864013;14176.362063707158;14198.219097949712;10776.838347424795;10895.945520272347;10897;10907.618233361794;10909.34543927367;14544.345504452325;14634.853651463562;15158.545243642488;15160.924195378953;15298.311575978885;5912.231409916683;5984.521238300926;6038.215032045894;6082.330943596201;6139;884.0275696733542;885.9202671759573;924.8242833861544;982.9698237227311;1000.9949950250348;28016.85991570029;28378.85810570934;28620.570691439643;28658.14025579236;28936.710632893824;852.2713080316364;984.8227319082633;988.283494466506;992.0773680477225;1026.8665073540392;12777.744445111046;13372;13382.732345353039;13465.326733663278;13589;289004;446603;458138;459905;460417;52631.21053184205;53238.73380633072;53327.73336133372;53598.196027059625;53731.731341343824;1105.1379923659558;1251.6245126462024;1261.5395380685984;1285.7299967006845;1316.782730849399;27426.314342141606;29567.556486652287;29929.102126936228;30084.84957575198;30407;38025;38621.4206786904;38631;38654.61345386622;39145.6085439142;198023;198580;199563;199947;199984;26909.596356054284;31299.84350078235;31888;32010.35979280355;32198.356032878743;36758.69171774553;39185.95569617064;39270.21459570735;39344.80327598344;40109.398359025225;33362.33275334528;33538.496922545695;33863.153421164665;34271.485927711605;34692.132696682784;33580.66419335873;33851.15372115717;33958.15104622404;34180.14549636279;34474.482882756274;33732.83133584316;33870.66129338675;34119.82940085284;34445.655543445246;34915.12712182114;29241.707582924748;30380.392392151593;30440.39119217559;30559.847200763856;30574.388512229187;24097.51804963856;25620.743792561836;26396.8680156598;27598;27917 04:48:16 INFO - PROCESS | 16549 | |2;jquery.html;362.3622424532823;362.9510016147821;365.4463487815959;370.3703703703701;372.73722025971693;15402.922985385072;15640;16857.83142168578;16865.07242101684;16899.493015209548;15547.766783498257;16045.518634440985;16136.515904522854;16168;16181.595460113504;4905.607551395898;4959.603231741461;5112.233165025239;5121.206213036985;5126.359205099363;5047.3438453001245;5051.1413059779925;5067.695938243699;5086.491350864902;5093.6943783372935;4917.139500587401;5087.6184286178495;5088;5100.591952643779;5102.438731739506;5064.746762661852;5068.087744206042;5089.770960306758;5100.209467532539;5111.361079864998;4527.864164075083;4555.385023021916;4557.726536407826;4557.886052848672;4561.1105834362315;18498.81501184998;19095.23619055236;19340.613187736166;19357.90321048386;19367.903160484108;2068.1830676882696;2073.533454972619;2074.5332300232476;2097.224027109979;2139.752591106652;12333.506659733599;12707.301098439582;12756.80864787029;13063.216207027514;13219.272939988297;1816.4641430777951;1845.9630807383778;1862.4505770797512;1870.1023508715894;1890.1022014543119;57653.71173144107;60064.49193850769;60252.39747602556;60541.09188362222;61044.08433873495;9519.571619277149;9568.56941437637;9928.950355248178;9972;10085.69742907714;12547.435365408579;12720.427580758887;12774.786395292433;12805.231686098863;12816.166949148275;7488.475806693588;7519.097708274932;7547.849043019109;7595.658195381111;7604.315611594983;7315.890261646079;7370.926290737131;7381.151167615685;7395.149557800814;7454.515456495311;5941.435563621449;5965.731542080617;6032.125341825411;6105.603135796159;6115.082737589397;1732.8873623214452;1736;1763.1272520102632;1774.6007148391766;1778.5020194345345;625.7371903800415;889.0975659705405;956.799072194833;989.5200827598609;1010.2776514791959;15762.374653829454;15762.842371576138;15942;16162.838371616133;16410.1794910254;895.7402353317595;897.4301318662566;905.3526728389234;926.2358554192817;940.8682784410188;9110.453372797654;9296.070392960784;9524.952375238217;9764.316497845224;9765.560549775277;407053;416653;426687;429044;438839;68249;73248.63375683088;75064.24935750682;75983.62008189924;76117.23882761212;967.9370840895319;973.7614284500202;989.0603926269929;997.3018886779283;998.8301988661945;14766.114033157615;14871.702565948404;14983.351831298767;15076.246187690353;15314.157721325435;36175.63824361723;36289.637103629684;36399;36679.26641467209;37168.814155929045;44035.77982110069;45296.773516132205;50426.49573504218;50648.49351506438;51067;7034.929650703428;7219.314165154512;7235.710571577289;7260.318330136832;7264.891026634499;8014.519128852287;9480.905190948002;10545.261831671709;10657.680269591925;10863.402512861869;9034.548272586477;9288.210502107397;9302.441853488812;9557.187639050759;9830.361026533252;8988.235999940078;9322.580483878106;9375.109364610624;9508.477033763209;9550.092741189575;9423;9541.666041688508;9740.707778766648;9741.366811157252;9795.314327996972;7419.629018549159;7448.217937116525;7590.354819840375;7603.619819008917;7650.2349765023055;9634.807303853744;9667.984861589714;9780.462074585967;9781.119699227103;9954.203663706741 04:48:16 INFO - PROCESS | 16549 | |3;mootools.html;1085.7231405991472;1422.7367936931669;1441.805356276903;1598.8001499812524;1774.6628140653274;7273.0908636420445;7421.81445463863;7434.1822399536;7435.665395057222;7455.552666839993;7419;7562.2059683733105;7563.697452101923;7585.748351521992;7607.923920760791;1945.9805401946012;2249.718785151856;2287.65685147228;2302.4128847143957;2311.6185829338224;2315.097112126272;2316.200910685811;2318.3392733071078;2319.5708793873187;2331.405491599648;2180.2151225558787;2260.8530445520987;2266.7166604174477;2268.9773102269014;2270.8751018693965;2281.840271181018;2316.559853627822;2318.8956496957676;2329.9981008166483;2333.614953532665;2290.6907567478343;2295.1966811615966;2297.115610489957;2301.7583153768946;2327.290176496168;7656.042994625672;7718.266764657405;7752.5348479091435;7753.689852405897;7753.806154846117;4659.370984917026;4796.664233503656;4805.663603547753;4810.591099756525;4811.158047341702;3030.8787648494035;3148.2286839724184;3217.276112874608;3260.0708797992456;3265.363254165439;1013.381837079381;1015.5582321690089;1025.318163421324;1041.7760181560925;1045.979080418395;10270.7432314192;10270.9486452568;10278.434686092261;10291.639792607222;10292.279540432099;4354.716943398669;4405.7797110145;4432.423784907941;4455.688101832905;4467.843625473158;8245.546494942715;8315.085340612528;8324.542150181676;8325.500469971821;8326.167383261625;4119.546849846514;4634.21218392874;4660.39414876064;4662.813487460464;4666;4275.273203555403;4313.352997050405;4317.525072242051;4331.935020974688;4358.498772641124;3542.71658267338;3640.5073919693327;3649.872254471081;3681;3690.0774806298427;1090.378484263962;1093.3767752381225;1093.578972095733;1098.2641630107846;1100.7688385438987;1231.58741821489;1235.0243307786927;1249.0195196770492;1251.4994002399112;1259.0934527140444;7298.598577078312;7379.262073792578;7384.778456646309;7417.109946806418;7437.256274372628;463.59898687635626;464.83963032753644;469.1344469453852;470.60704311899946;477.9091972525209;5611.0741727615305;5614.270144881221;5627.774889004476;5632.633878797865;5677.943220567741;8991.14584114508;9135;9333.859992099988;9444.90555094454;9447.385919915183;9081.409708368936;9180.908190918006;9239.445633262027;9259.074092590687;9261.305402094735;7072.434205263567;7108.644567771591;7122.5726456412785;7192.892106618405;7192.964035179791;6803.217629972616;6839.31606839332;6852.45180385558;6861.862762744618;6890.276520965427;7949.880751788844;8296.128906464975;8378.790530236549;8404.789880252798;8427.283680887193;8162.591870406574;8226.506409615442;8231;8377.874331884905;8380.24577788002;5890.293164820249;6512.5766825156215;6636.7013484392355;6658.733650654113;6751.054852320777;7189.496735228484;7194.640267986684;7216.675249613675;7241.275872412716;7247.637618119178;6362.809115726535;6564.671766411756;6572.244191917991;6664.266930637529;6670.733170673118;6612.404883560503;6642.667866606554;6658.234303055211;6659.866802664016;6706.83232919181;6962.651867406508;6981.5461994970165;7009.894851577128;7024.8595028098125;7030.261822508563;6326.493880489457;6408.647524386203;6409.9038514423255;6481.837954051187;6483.870322593616;6473.287938326875;6481.222253329631;6505.186851643544;6532.608043517404;6540.215174179129 04:48:16 INFO - PROCESS | 16549 | |4;prototype.html;313.8085767681715;315.92101974506375;320.8812739286464;320.9165616939596;326.7777911020507;5218.243354713569;5408.242846001563;5414.296141501604;5418.24144619753;5427.3215848019;5249.448807875166;5347.064263753847;5349.277847490587;5365.275687782158;5367.06076436624;3876.8836934891997;3958.5051868516434;4090.1206240658253;4132.669386449092;4134;4109.856155034575;4121.381792731085;4127.442795222637;4130.938035929464;4132.607402296777;4062.431259623655;4068.7965601719943;4080.0411903202726;4080.06158583526;4081.9183616327805;3905.7461265017682;3948.5853985331414;4028.1742242840146;4085.734427262248;4087.9386809197886;3555.9111022224392;3573.9642603573893;3574.5889222739456;3575.624559421249;3582.140286331288;5069.264956581312;5077.898442031175;5080.74596270185;5087.236914462823;5089.54194122527;4723.811047558093;4737.289406589005;4741;4743;4743.667943243974;5585.944140558583;5586.441355864422;5586.553075753971;5592.468715472064;5620.494155525981;3943.0339566806315;3946.1910308386714;3950.4469374287623;3950.703697222691;3961.9698878291565;5747.195392645033;5798.594098413113;5867.618604790675;5895.646261224298;5936.1095835625;3964.0288129407904;3966.5835087315995;3986.362182050858;3986.5016872890887;3990.8004599769897;4046.190761847642;4046.5751096135073;4048.7773172475795;4049.2913740095955;4052.8986775330854;4684.2271025281125;4687.7656117194;4692.296155576622;4693.943862630881;4698.718076915396;5610.961972035187;5647.604667673223;5647.830565083054;5648.378678345379;5650.29371328584;1420.1692010174163;1442.2428225181654;1442.8412874583787;1443.5308524729505;1444.59551325629;908.7455512456522;944.997568020975;973.5035132082688;973.5473005052543;995.999020983921;4879.292502587176;4956.083124621957;4968.329275547755;4976.527229913152;4980.078685443204;5807.303123625192;5865.325487568899;5888.352281249059;5888.735006924699;5889.440503152194;4990.426100998359;4992.400911890596;4996.325496058058;4997.750112494361;5003.224500202475;3111.719945204897;3147.716705496516;3151.416987857254;3156.210947263184;3157.0213233897566;5569.582281328835;5570.693611851306;5571.66570005801;5575.414581468968;5584.52531534816;5831.912521312183;6027.186329845415;6032.698365081728;6037.547183961133;6040.36576159497;5536.806211782568;5558.055130627722;5566.387697353288;5571.9442805571425;5573.164025396223;5869;5869.383714710065;5871.6183448075735;5875.735591898289;5884.146798714248;5719.342275638355;5748.827535173951;5750.913736294043;5759.596828222152;5772.567057470623;5379.1662292344745;5530.391656917655;5534.889302214014;5542.8337149885565;5543.1408131739645;4061.1268577256033;4064.248114098901;4066.1867626475414;4066.268071747114;4067.4102255172243;5809.5352371811;5838.065909454467;5854.443827836349;5865.354810970704;5870.236869206976;5633.295838020247;5645.71771411436;5648.830535083954;5649.887002260014;5651.88696226065;5612.158176273591;5627.296587926509;5631.774729010794;5640.717964101696;5642.6614403135945;5396.3524377075;5516.862078448071;5534.91697624544;5549.445055494418;5552.416996215501;5647.29408823897;5668.716564171693;5677.858053548694;5688.800891968761;5691.260136182435;5508.256385387921;5545.556355491632;5552.944470555404;5554.528050066816;5555.0834112371 04:48:16 INFO - PROCESS | 16549 | |5;yui.html;661.2620573590227;728.2462651156054;747.8856503809324;785.9607019649012;790.671871173463;14750;15044.924775376108;15081.321340539675;15083.396664133421;15097.547073587797;14188.787168192459;14200.289985500734;14212.076215046014;14227.857721422783;14246.857531424683;655.9639219842907;806.9475484093545;815.2621877201112;831.4512421801612;832.3590835057003;814.3241109878816;817.6034623207769;821.9054808697017;823.8311146215011;824.3034635732796;862.4868203418956;870.29071306885;870.6473878079388;871.255076909243;871.3464901324007;679.9558028728167;852.0882655558555;856.4347530629785;858.4162769316894;868.7306934850217;629.6599836088507;630.2940706408806;631.2645767680647;631.381246378547;631.4001698386505;13152.079354445194;13222.404991775393;13270.668233294246;13271.86728132716;13277.46890124394;12187.51249950001;12221.083418743541;12263.570775022921;12827.10210285271;12835.550755723598;10909.509072091696;11065.225434219608;11068.335899846035;11621.24461909973;11692.707682307926;3342.9331413371838;3346.330733853215;3371.325734853039;3416.641252668459;3434.1929646533044;46046.309305360446;46120.077598447846;46196.07607847858;46678;46680;10017.749556261151;10050.296479246528;10098.899011009797;10185.33795303303;10296.382217067;15516.767248491282;15544.533663990098;15585.844141558438;15594.142322172389;15597.142157181237;6935.791926242221;7023.89464158038;7062.964685176541;7087.858242835217;7199.849528787494;3814.771113733185;3840.462335273064;3861.9765762073075;3875.612438756158;3926.1755031443145;2834.1780883543543;2873.726995935383;2879.136259122255;2881.4957382457987;2882.0345184363473;500.73961539999;515.4047075627581;532.9893402132013;534.3721127675044;546.0798554435788;497.9975100124549;573.6930742053065;575.4389470266457;592.8310431526994;594.1444320179015;7022.754203602849;7116.252793456716;7344.853102937911;7362.3741981932135;7477.027986361738;459.3018611710182;508.905852417304;519.7115600841494;566.5212895103631;578.774278031568;3457.2566898117025;3527.5766907971206;3625.4380571011534;3661.7436779425716;3693.390590552529;55630.721846391316;56068.43931560714;56099.71950140223;56163.157552636745;56271;47258.29112563314;47644.28533571999;48187.518124819006;48201.517984820406;48432.75783621059;42226.155476890905;42309.36535951963;42447;42500.36249456261;42520.78739606282;7231.63841807897;7373.815654608463;7444.813879652836;7456.813579660552;7457.216992215956;29526.261843454085;29790.553141703323;30481.54277685792;30614.84692576612;30643.387132257674;39720.205595888496;40574.79712601418;41024.79487602543;41076;41293.793531032155;9159;9367.953160234156;9411.576479058322;9511;9615.278854086111;8717.128287171232;8784.945806503261;8797.780055498408;8839.51382673959;8976.281897448058;8968.910310896808;10383.740406489596;10511.57953681844;10633.149348052291;10825.783484330426;10158.644447444303;10239.795204096024;10249.282550221413;10446.268761186644;10793.622223222465;9936.801263974825;10126.13927816144;10289.125424338716;10423.791524169323;10487.161027117965;9134.177923986874;9218.907810922074;9343.626254949726;9571.090746379083;9695.224382049279;8885.822283554422;8948.725577704894;9145.86281205769;9164.862527061967;9202.21781148583 04:48:16 INFO - PROCESS | 16549 | __end_tp_report 04:48:16 INFO - PROCESS | 16549 | __start_cc_report 04:48:16 INFO - PROCESS | 16549 | _x_x_mozilla_cycle_collect,892 04:48:16 INFO - PROCESS | 16549 | __end_cc_report 04:48:16 INFO - PROCESS | 16549 | __startTimestamp1458215296920__endTimestamp 04:48:16 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | ------- Summary: start ------- 04:48:16 INFO - PROCESS | 16549 | Number of tests: 6 04:48:16 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | [#0] dojo.html Cycles:165 Average:4688.13 Median:4830.15 stddev:486.53 (10.1%) stddev-sans-first:460.43 04:48:16 INFO - PROCESS | 16549 | Values: 2629.3 2688.4 2698.1 2701.2 2720.7 4638.6 4695.1 4708.1 4723.7 4742.4 4686.5 4724.0 4752.6 4752.8 4827.2 4312.1 4312.4 4339.8 4372.6 4434.4 4289.7 4346.9 4373.0 4406.2 4430.6 4314.3 4333.8 4347.1 4408.2 4432.5 4342.2 4350.3 4357.7 4380.1 4400.4 4236.6 4340.6 4348.2 4356.3 4387.9 4524.1 4582.7 4619.3 4638.4 4649.8 5054.0 5092.6 5099.2 5144.4 5154.6 4925.7 5038.7 5108.2 5117.8 5141.2 4748.8 4768.6 4773.4 4789.7 4820.0 5216.4 5232.5 5233.0 5234.5 5277.6 4849.3 4952.4 5008.3 5016.9 5078.5 5046.9 5059.3 5067.7 5072.5 5103.3 5012.5 5017.6 5021.9 5027.1 5070.3 4865.0 4942.6 5021.2 5052.5 5064.8 4266.7 4272.3 4280.8 4283.9 4332.8 3770.6 3771.7 3771.8 3779.2 3798.1 4323.5 4340.5 4393.8 4407.4 4416.4 5087.6 5099.8 5105.7 5108.4 5165.2 4386.9 4398.5 4401.5 4406.3 4438.3 4454.0 4526.0 4584.7 4618.5 4639.7 4810.4 4820.9 4830.2 4840.4 4893.1 4954.3 5083.2 5098.9 5101.2 5151.6 4797.1 4809.4 4828.6 4859.8 4875.9 4978.5 5017.4 5023.3 5028.1 5067.8 4938.7 5064.5 5091.2 5108.9 5164.0 4882.2 4905.4 4913.0 4914.2 4955.3 4899.6 4904.5 4907.0 4912.5 4954.5 4754.0 4807.8 4839.8 4895.4 4929.2 4954.1 4977.9 4984.5 4996.5 5039.9 4844.6 4865.8 4868.2 4868.4 4920.5 04:48:16 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | [#1] ext.html Cycles:180 Average:42356.95 Median:18765.53 stddev:77842.35 (414.8%) stddev-sans-first:77997.39 04:48:16 INFO - PROCESS | 16549 | Values: 538.7 539.7 543.3 564.0 574.6 26803.3 27229.6 27238.5 27248.3 27269.3 29571.7 34661.0 35068.0 35113.8 35227.5 7741.1 7926.2 7928.6 7931.4 7935.0 7836.0 7951.6 7965.2 7970.3 7975.2 7964.5 8016.9 8023.8 8026.7 8034.7 7913.1 7978.1 7982.1 7988.0 7990.5 7854.9 7996.0 7997.2 7997.7 8006.7 39611.0 39628.2 39934.0 40014.4 40073.6 2905.4 2978.7 3115.5 3256.2 3377.8 29443.7 29745.4 29773.3 29944.0 30440.2 3269.2 3371.7 3398.3 3411.2 3424.0 184992.0 185703.0 185783.0 186193.0 186533.0 43710.6 58505.4 58817.7 58826.0 58917.4 42441.6 42671.4 42733.8 42744.6 42761.8 13916.2 14120.2 14143.4 14176.4 14198.2 10776.8 10895.9 10897.0 10907.6 10909.3 14544.3 14634.9 15158.5 15160.9 15298.3 5912.2 5984.5 6038.2 6082.3 6139.0 884.0 885.9 924.8 983.0 1001.0 28016.9 28378.9 28620.6 28658.1 28936.7 852.3 984.8 988.3 992.1 1026.9 12777.7 13372.0 13382.7 13465.3 13589.0 289004.0 446603.0 458138.0 459905.0 460417.0 52631.2 53238.7 53327.7 53598.2 53731.7 1105.1 1251.6 1261.5 1285.7 1316.8 27426.3 29567.6 29929.1 30084.8 30407.0 38025.0 38621.4 38631.0 38654.6 39145.6 198023.0 198580.0 199563.0 199947.0 199984.0 26909.6 31299.8 31888.0 32010.4 32198.4 36758.7 39186.0 39270.2 39344.8 40109.4 33362.3 33538.5 33863.2 34271.5 34692.1 33580.7 33851.2 33958.2 34180.1 34474.5 33732.8 33870.7 34119.8 34445.7 34915.1 29241.7 30380.4 30440.4 30559.8 30574.4 24097.5 25620.7 26396.9 27598.0 27917.0 04:48:16 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | [#2] jquery.html Cycles:180 Average:24637.45 Median:5091.73 stddev:69556.62 (1366.1%) stddev-sans-first:69727.86 04:48:16 INFO - PROCESS | 16549 | Values: 362.4 363.0 365.4 370.4 372.7 15402.9 15640.0 16857.8 16865.1 16899.5 15547.8 16045.5 16136.5 16168.0 16181.6 4905.6 4959.6 5112.2 5121.2 5126.4 5047.3 5051.1 5067.7 5086.5 5093.7 4917.1 5087.6 5088.0 5100.6 5102.4 5064.7 5068.1 5089.8 5100.2 5111.4 4527.9 4555.4 4557.7 4557.9 4561.1 18498.8 19095.2 19340.6 19357.9 19367.9 2068.2 2073.5 2074.5 2097.2 2139.8 12333.5 12707.3 12756.8 13063.2 13219.3 1816.5 1846.0 1862.5 1870.1 1890.1 57653.7 60064.5 60252.4 60541.1 61044.1 9519.6 9568.6 9929.0 9972.0 10085.7 12547.4 12720.4 12774.8 12805.2 12816.2 7488.5 7519.1 7547.8 7595.7 7604.3 7315.9 7370.9 7381.2 7395.1 7454.5 5941.4 5965.7 6032.1 6105.6 6115.1 1732.9 1736.0 1763.1 1774.6 1778.5 625.7 889.1 956.8 989.5 1010.3 15762.4 15762.8 15942.0 16162.8 16410.2 895.7 897.4 905.4 926.2 940.9 9110.5 9296.1 9525.0 9764.3 9765.6 407053.0 416653.0 426687.0 429044.0 438839.0 68249.0 73248.6 75064.2 75983.6 76117.2 967.9 973.8 989.1 997.3 998.8 14766.1 14871.7 14983.4 15076.2 15314.2 36175.6 36289.6 36399.0 36679.3 37168.8 44035.8 45296.8 50426.5 50648.5 51067.0 7034.9 7219.3 7235.7 7260.3 7264.9 8014.5 9480.9 10545.3 10657.7 10863.4 9034.5 9288.2 9302.4 9557.2 9830.4 8988.2 9322.6 9375.1 9508.5 9550.1 9423.0 9541.7 9740.7 9741.4 9795.3 7419.6 7448.2 7590.4 7603.6 7650.2 9634.8 9668.0 9780.5 9781.1 9954.2 04:48:16 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | [#3] mootools.html Cycles:180 Average:5327.14 Median:6108.39 stddev:2738.63 (44.8%) stddev-sans-first:2727.75 04:48:16 INFO - PROCESS | 16549 | Values: 1085.7 1422.7 1441.8 1598.8 1774.7 7273.1 7421.8 7434.2 7435.7 7455.6 7419.0 7562.2 7563.7 7585.7 7607.9 1946.0 2249.7 2287.7 2302.4 2311.6 2315.1 2316.2 2318.3 2319.6 2331.4 2180.2 2260.9 2266.7 2269.0 2270.9 2281.8 2316.6 2318.9 2330.0 2333.6 2290.7 2295.2 2297.1 2301.8 2327.3 7656.0 7718.3 7752.5 7753.7 7753.8 4659.4 4796.7 4805.7 4810.6 4811.2 3030.9 3148.2 3217.3 3260.1 3265.4 1013.4 1015.6 1025.3 1041.8 1046.0 10270.7 10270.9 10278.4 10291.6 10292.3 4354.7 4405.8 4432.4 4455.7 4467.8 8245.5 8315.1 8324.5 8325.5 8326.2 4119.5 4634.2 4660.4 4662.8 4666.0 4275.3 4313.4 4317.5 4331.9 4358.5 3542.7 3640.5 3649.9 3681.0 3690.1 1090.4 1093.4 1093.6 1098.3 1100.8 1231.6 1235.0 1249.0 1251.5 1259.1 7298.6 7379.3 7384.8 7417.1 7437.3 463.6 464.8 469.1 470.6 477.9 5611.1 5614.3 5627.8 5632.6 5677.9 8991.1 9135.0 9333.9 9444.9 9447.4 9081.4 9180.9 9239.4 9259.1 9261.3 7072.4 7108.6 7122.6 7192.9 7193.0 6803.2 6839.3 6852.5 6861.9 6890.3 7949.9 8296.1 8378.8 8404.8 8427.3 8162.6 8226.5 8231.0 8377.9 8380.2 5890.3 6512.6 6636.7 6658.7 6751.1 7189.5 7194.6 7216.7 7241.3 7247.6 6362.8 6564.7 6572.2 6664.3 6670.7 6612.4 6642.7 6658.2 6659.9 6706.8 6962.7 6981.5 7009.9 7024.9 7030.3 6326.5 6408.6 6409.9 6481.8 6483.9 6473.3 6481.2 6505.2 6532.6 6540.2 04:48:16 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | [#4] prototype.html Cycles:180 Average:4665.62 Median:5373.11 stddev:1381.17 (25.7%) stddev-sans-first:1345.87 04:48:16 INFO - PROCESS | 16549 | Values: 313.8 315.9 320.9 320.9 326.8 5218.2 5408.2 5414.3 5418.2 5427.3 5249.4 5347.1 5349.3 5365.3 5367.1 3876.9 3958.5 4090.1 4132.7 4134.0 4109.9 4121.4 4127.4 4130.9 4132.6 4062.4 4068.8 4080.0 4080.1 4081.9 3905.7 3948.6 4028.2 4085.7 4087.9 3555.9 3574.0 3574.6 3575.6 3582.1 5069.3 5077.9 5080.7 5087.2 5089.5 4723.8 4737.3 4741.0 4743.0 4743.7 5585.9 5586.4 5586.6 5592.5 5620.5 3943.0 3946.2 3950.4 3950.7 3962.0 5747.2 5798.6 5867.6 5895.6 5936.1 3964.0 3966.6 3986.4 3986.5 3990.8 4046.2 4046.6 4048.8 4049.3 4052.9 4684.2 4687.8 4692.3 4693.9 4698.7 5611.0 5647.6 5647.8 5648.4 5650.3 1420.2 1442.2 1442.8 1443.5 1444.6 908.7 945.0 973.5 973.5 996.0 4879.3 4956.1 4968.3 4976.5 4980.1 5807.3 5865.3 5888.4 5888.7 5889.4 4990.4 4992.4 4996.3 4997.8 5003.2 3111.7 3147.7 3151.4 3156.2 3157.0 5569.6 5570.7 5571.7 5575.4 5584.5 5831.9 6027.2 6032.7 6037.5 6040.4 5536.8 5558.1 5566.4 5571.9 5573.2 5869.0 5869.4 5871.6 5875.7 5884.1 5719.3 5748.8 5750.9 5759.6 5772.6 5379.2 5530.4 5534.9 5542.8 5543.1 4061.1 4064.2 4066.2 4066.3 4067.4 5809.5 5838.1 5854.4 5865.4 5870.2 5633.3 5645.7 5648.8 5649.9 5651.9 5612.2 5627.3 5631.8 5640.7 5642.7 5396.4 5516.9 5534.9 5549.4 5552.4 5647.3 5668.7 5677.9 5688.8 5691.3 5508.3 5545.6 5552.9 5554.5 5555.1 04:48:16 INFO - PROCESS | 16549 | 04:48:16 INFO - PROCESS | 16549 | [#5] yui.html Cycles:180 Average:12913.97 Median:47915.90 stddev:14995.76 (31.3%) stddev-sans-first:15009.60 04:48:16 INFO - PROCESS | 16549 | Values: 661.3 728.2 747.9 786.0 790.7 14750.0 15044.9 15081.3 15083.4 15097.5 14188.8 14200.3 14212.1 14227.9 14246.9 656.0 806.9 815.3 831.5 832.4 814.3 817.6 821.9 823.8 824.3 862.5 870.3 870.6 871.3 871.3 680.0 852.1 856.4 858.4 868.7 629.7 630.3 631.3 631.4 631.4 13152.1 13222.4 13270.7 13271.9 13277.5 12187.5 12221.1 12263.6 12827.1 12835.6 10909.5 11065.2 11068.3 11621.2 11692.7 3342.9 3346.3 3371.3 3416.6 3434.2 46046.3 46120.1 46196.1 46678.0 46680.0 10017.7 10050.3 10098.9 10185.3 10296.4 15516.8 15544.5 15585.8 15594.1 15597.1 6935.8 7023.9 7063.0 7087.9 7199.8 3814.8 3840.5 3862.0 3875.6 3926.2 2834.2 2873.7 2879.1 2881.5 2882.0 500.7 515.4 533.0 534.4 546.1 498.0 573.7 575.4 592.8 594.1 7022.8 7116.3 7344.9 7362.4 7477.0 459.3 508.9 519.7 566.5 578.8 3457.3 3527.6 3625.4 3661.7 3693.4 55630.7 56068.4 56099.7 56163.2 56271.0 47258.3 47644.3 48187.5 48201.5 48432.8 42226.2 42309.4 42447.0 42500.4 42520.8 7231.6 7373.8 7444.8 7456.8 7457.2 29526.3 29790.6 30481.5 30614.8 30643.4 39720.2 40574.8 41024.8 41076.0 41293.8 9159.0 9368.0 9411.6 9511.0 9615.3 8717.1 8784.9 8797.8 8839.5 8976.3 8968.9 10383.7 10511.6 10633.1 10825.8 10158.6 10239.8 10249.3 10446.3 10793.6 9936.8 10126.1 10289.1 10423.8 10487.2 9134.2 9218.9 9343.6 9571.1 9695.2 8885.8 8948.7 9145.9 9164.9 9202.2 04:48:16 INFO - PROCESS | 16549 | -------- Summary: end -------- 04:48:16 INFO - PROCESS | 16549 | 04:48:17 INFO - TEST-INFO | 16549: exit 0 04:48:17 INFO - TEST-OK | dromaeo_css | took 1116149ms 04:48:17 INFO - TEST-START | kraken 04:48:17 INFO - operating with platform_type : linux_ 04:48:17 INFO - Initialising browser for kraken test... 04:48:17 INFO - TEST-INFO | started process 16728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsSjAq2/profile http://localhost:40130/getInfo.html) 04:48:22 INFO - PROCESS | 16728 | __metrics Screen width/height:1600/1200 04:48:22 INFO - PROCESS | 16728 | colorDepth:24 04:48:22 INFO - PROCESS | 16728 | Browser inner width/height: 1024/697 04:48:22 INFO - PROCESS | 16728 | __metrics 04:48:23 ERROR - PROCESS | 16728 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:48:23 INFO - TEST-INFO | 16728: exit 0 04:48:23 INFO - Browser initialized. 04:48:23 INFO - Running cycle 1/1 for kraken test... 04:48:23 INFO - TEST-INFO | started process 16810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsSjAq2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:35 INFO - PROCESS | 16810 | RSS: Main: 154570752 04:48:35 INFO - PROCESS | 16810 | 04:48:38 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-beat-detection) 04:48:39 INFO - PROCESS | 16810 | RSS: Main: 196653056 04:48:39 INFO - PROCESS | 16810 | 04:48:41 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-dft) 04:48:42 INFO - PROCESS | 16810 | RSS: Main: 187342848 04:48:42 INFO - PROCESS | 16810 | 04:48:45 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-fft) 04:48:46 INFO - PROCESS | 16810 | RSS: Main: 172376064 04:48:46 INFO - PROCESS | 16810 | 04:48:48 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40130/tests/kraken/driver.html?testName=audio-oscillator) 04:48:48 INFO - PROCESS | 16810 | RSS: Main: 172961792 04:48:48 INFO - PROCESS | 16810 | 04:48:50 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:48:51 INFO - PROCESS | 16810 | RSS: Main: 175325184 04:48:51 INFO - PROCESS | 16810 | 04:48:54 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-darkroom) 04:48:55 INFO - PROCESS | 16810 | RSS: Main: 175247360 04:48:55 INFO - PROCESS | 16810 | 04:48:58 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40130/tests/kraken/driver.html?testName=imaging-desaturate) 04:48:59 INFO - PROCESS | 16810 | RSS: Main: 176967680 04:48:59 INFO - PROCESS | 16810 | 04:49:02 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40130/tests/kraken/driver.html?testName=json-parse-financial) 04:49:02 INFO - PROCESS | 16810 | RSS: Main: 176517120 04:49:02 INFO - PROCESS | 16810 | 04:49:04 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40130/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:04 INFO - PROCESS | 16810 | RSS: Main: 187011072 04:49:04 INFO - PROCESS | 16810 | 04:49:06 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:49:07 INFO - PROCESS | 16810 | RSS: Main: 186327040 04:49:07 INFO - PROCESS | 16810 | 04:49:09 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:49:10 INFO - PROCESS | 16810 | RSS: Main: 196325376 04:49:10 INFO - PROCESS | 16810 | 04:49:12 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:49:13 INFO - PROCESS | 16810 | RSS: Main: 200679424 04:49:13 INFO - PROCESS | 16810 | 04:49:15 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:49:16 INFO - PROCESS | 16810 | RSS: Main: 198930432 04:49:16 INFO - PROCESS | 16810 | 04:49:17 INFO - PROCESS | 16810 | Cycle 1(1): loaded http://localhost:40130/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40130/tests/kraken/driver.html?testName=ai-astar) 04:49:18 INFO - PROCESS | 16810 | RSS: Main: 259371008 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | __start_tp_report 04:49:18 INFO - PROCESS | 16810 | _x_x_mozilla_page_load 04:49:18 INFO - PROCESS | 16810 | _x_x_mozilla_page_load_details 04:49:18 INFO - PROCESS | 16810 | |i|pagename|runs| 04:49:18 INFO - PROCESS | 16810 | |0;ai-astar;111;113;109;112;112;112;102;113;113;113 04:49:18 INFO - PROCESS | 16810 | |1;audio-beat-detection;158;129;150;167;130;151;159;137;177;132 04:49:18 INFO - PROCESS | 16810 | |2;audio-dft;161;161;161;160;161;161;163;161;162;161 04:49:18 INFO - PROCESS | 16810 | |3;audio-fft;73;73;101;98;72;72;73;112;93;76 04:49:18 INFO - PROCESS | 16810 | |4;audio-oscillator;94;93;144;93;93;93;142;94;93;138 04:49:18 INFO - PROCESS | 16810 | |5;imaging-gaussian-blur;116;117;117;117;118;117;117;117;116;117 04:49:18 INFO - PROCESS | 16810 | |6;imaging-darkroom;148;146;147;146;148;145;147;147;147;146 04:49:18 INFO - PROCESS | 16810 | |7;imaging-desaturate;96;96;95;95;95;96;96;96;96;95 04:49:18 INFO - PROCESS | 16810 | |8;json-parse-financial;66;64;63;64;63;64;64;73;61;61 04:49:18 INFO - PROCESS | 16810 | |9;json-stringify-tinderbox;63;64;65;64;64;65;65;64;63;64 04:49:18 INFO - PROCESS | 16810 | |10;stanford-crypto-aes;81;81;83;81;82;83;82;82;82;82 04:49:18 INFO - PROCESS | 16810 | |11;stanford-crypto-ccm;115;116;112;112;117;116;125;117;122;113 04:49:18 INFO - PROCESS | 16810 | |12;stanford-crypto-pbkdf2;142;130;142;143;142;128;142;141;141;139 04:49:18 INFO - PROCESS | 16810 | |13;stanford-crypto-sha256-iterative;67;67;67;66;65;66;67;66;67;65 04:49:18 INFO - PROCESS | 16810 | __end_tp_report 04:49:18 INFO - PROCESS | 16810 | __start_cc_report 04:49:18 INFO - PROCESS | 16810 | _x_x_mozilla_cycle_collect,1120 04:49:18 INFO - PROCESS | 16810 | __end_cc_report 04:49:18 INFO - PROCESS | 16810 | __startTimestamp1458215358166__endTimestamp 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | ------- Summary: start ------- 04:49:18 INFO - PROCESS | 16810 | Number of tests: 14 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.50 stddev:3.40 (3.0%) stddev-sans-first:3.61 04:49:18 INFO - PROCESS | 16810 | Values: 111.0 113.0 109.0 112.0 112.0 112.0 102.0 113.0 113.0 113.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.50 stddev:16.63 (10.8%) stddev-sans-first:17.31 04:49:18 INFO - PROCESS | 16810 | Values: 158.0 129.0 150.0 167.0 130.0 151.0 159.0 137.0 177.0 132.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 04:49:18 INFO - PROCESS | 16810 | Values: 161.0 161.0 161.0 160.0 161.0 161.0 163.0 161.0 162.0 161.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#3] audio-fft Cycles:10 Average:84.30 Median:73.00 stddev:15.14 (20.7%) stddev-sans-first:15.50 04:49:18 INFO - PROCESS | 16810 | Values: 73.0 73.0 101.0 98.0 72.0 72.0 73.0 112.0 93.0 76.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:93.00 stddev:23.26 (25.0%) stddev-sans-first:24.13 04:49:18 INFO - PROCESS | 16810 | Values: 94.0 93.0 144.0 93.0 93.0 93.0 142.0 94.0 93.0 138.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 04:49:18 INFO - PROCESS | 16810 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 04:49:18 INFO - PROCESS | 16810 | Values: 148.0 146.0 147.0 146.0 148.0 145.0 147.0 147.0 147.0 146.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:49:18 INFO - PROCESS | 16810 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:3.40 (5.3%) stddev-sans-first:3.55 04:49:18 INFO - PROCESS | 16810 | Values: 66.0 64.0 63.0 64.0 63.0 64.0 64.0 73.0 61.0 61.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 04:49:18 INFO - PROCESS | 16810 | Values: 63.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 63.0 64.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 04:49:18 INFO - PROCESS | 16810 | Values: 81.0 81.0 83.0 81.0 82.0 83.0 82.0 82.0 82.0 82.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:116.50 stddev:4.20 (3.6%) stddev-sans-first:4.42 04:49:18 INFO - PROCESS | 16810 | Values: 115.0 116.0 112.0 112.0 117.0 116.0 125.0 117.0 122.0 113.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:142.00 stddev:5.40 (3.8%) stddev-sans-first:5.61 04:49:18 INFO - PROCESS | 16810 | Values: 142.0 130.0 142.0 143.0 142.0 128.0 142.0 141.0 141.0 139.0 04:49:18 INFO - PROCESS | 16810 | 04:49:18 INFO - PROCESS | 16810 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 04:49:18 INFO - PROCESS | 16810 | Values: 67.0 67.0 67.0 66.0 65.0 66.0 67.0 66.0 67.0 65.0 04:49:18 INFO - PROCESS | 16810 | -------- Summary: end -------- 04:49:18 INFO - PROCESS | 16810 | 04:49:19 INFO - TEST-INFO | 16810: exit 0 04:49:19 INFO - TEST-OK | kraken | took 61473ms 04:49:19 INFO - SUITE-END | took 1177s 04:49:19 INFO - Completed test suite (00:19:37) 04:49:19 INFO - javascript benchmark 04:49:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.2900916752474, 2688.448867982064, 2698.082651898354, 2701.1626395817284, 2720.6871209810865, 4638.582527572517, 4695.084458530588, 4708.058388322336, 4723.669343145977, 4742.383490146276, 4686.46105697844, 4724.0, 4752.59602933751, 4752.762361881901, 4827.227643577028, 4312.094460163369, 4312.396264522961, 4339.761313127777, 4372.584604462571, 4434.401355816955, 4289.656827453812, 4346.9347959780625, 4372.956270437287, 4406.162829062484, 4430.55694430556, 4314.309710446313, 4333.783310834478, 4347.108842687241, 4408.184485870092, 4432.512423633398, 4342.1532801103795, 4350.32569951658, 4357.738535687838, 4380.08018316154, 4400.383946247528, 4236.639885609727, 4340.6093451589195, 4348.173846969065, 4356.346548017791, 4387.890302742425, 4524.11779702958, 4582.725036497787, 4619.307103934403, 4638.397008388922, 4649.814007439699, 5054.014467178901, 5092.567131793802, 5099.235114732783, 5144.356955380577, 5154.561862241714, 4925.704457732511, 5038.748062596892, 5108.182690769459, 5117.8464646060675, 5141.15170996785, 4748.762561871893, 4768.642351823627, 4773.427188737373, 4789.664723469358, 4819.9999999999645, 5216.400113986864, 5232.450592687789, 5233.0, 5234.528892399626, 5277.604179686539, 4849.321095046696, 4952.405711314594, 5008.273800298936, 5016.924746128811, 5078.492150784966, 5046.924296135561, 5059.342285502935, 5067.670601410897, 5072.4673909239, 5103.311053007871, 5012.548870601663, 5017.623678224148, 5021.949780502148, 5027.145385284511, 5070.315507406527, 4865.0, 4942.604591632733, 5021.171506701427, 5052.469490703496, 5064.797408103708, 4266.65866730667, 4272.273713468718, 4280.828766849291, 4283.892902677458, 4332.848350307724, 3770.5852356240794, 3771.73597848148, 3771.8114094295174, 3779.1874746929543, 3798.0504873781556, 4323.48118225815, 4340.544242854518, 4393.780310984502, 4407.405000324915, 4416.447944006999, 5087.618428617869, 5099.77051032697, 5105.744712764347, 5108.438071812097, 5165.225216217522, 4386.868393948187, 4398.516163222043, 4401.471823381215, 4406.33904914259, 4438.334249862546, 4454.020115574568, 4526.0, 4584.701994370355, 4618.515055919147, 4639.652026098056, 4810.374651295309, 4820.855374338776, 4830.154722923545, 4840.394950631171, 4893.143699852582, 4954.256861470808, 5083.212102124176, 5098.898022039612, 5101.234814777813, 5151.613628977917, 4797.064572408347, 4809.422869255712, 4828.589569886599, 4859.805607775791, 4875.853724388274, 4978.5270399312, 5017.397912250553, 5023.34696489454, 5028.145215313332, 5067.77195026232, 4938.703677779345, 5064.493550645054, 5091.159958606789, 5108.948910510847, 5164.04465173944, 4882.194437917704, 4905.3623029006, 4912.950870491392, 4914.238293064581, 4955.331030310862, 4899.583535399531, 4904.460509343898, 4906.965256051455, 4912.533309335608, 4954.529319714621, 4753.977894752645, 4807.7836497357, 4839.806407743651, 4895.363602731622, 4929.186684197068, 4954.083494553519, 4977.900441991067, 4984.4517103117905, 4996.525330093636, 5039.924401134059, 4844.636652251025, 4865.756712164449, 4868.221084626584, 4868.440129385166, 4920.45874953762], "unit": "score", "name": "dojo.html", "value": 4657.629828536329}, {"lowerIsBetter": false, "replicates": [538.6902531044648, 539.7220431477792, 543.2991441041057, 563.9904570818235, 574.5547200919287, 26803.329916752067, 27229.591556126674, 27238.45523089542, 27248.31879203016, 27269.318267043334, 29571.704282957166, 34661.0, 35068.0, 35113.824430877874, 35227.53407261493, 7741.109772376164, 7926.167752386003, 7928.603569821515, 7931.405144614148, 7934.960325198366, 7836.0, 7951.642176102089, 7965.243301886311, 7970.282674559288, 7975.162607926171, 7964.522128672269, 8016.919830801705, 8023.839523209533, 8026.719064832732, 8034.678612855508, 7913.089994650602, 7978.082520510099, 7982.1219665837, 7988.041435027805, 7990.480618759762, 7854.921450785476, 7996.0, 7997.160298168725, 7997.720079797237, 8006.719764808262, 39611.0, 39628.20743585141, 39934.0, 40014.39978400326, 40073.59926400757, 2905.375344300964, 2978.704263645321, 3115.4703700370765, 3256.2022304535303, 3377.7973321600784, 29443.70556294431, 29745.405091898258, 29773.255668608243, 29944.0, 30440.238994025105, 3269.182704323919, 3371.7471189660873, 3398.269372084989, 3411.232472693649, 3424.0412684448393, 184992.0, 185703.0, 185782.99999999866, 186193.0, 186533.0, 43710.56289437129, 58505.41494585085, 58817.70591147017, 58826.0, 58917.410825891195, 42441.575584243765, 42671.35992960108, 42733.78633106877, 42744.57255427468, 42761.79953906666, 13916.165030098227, 14120.152790832582, 14143.36354864013, 14176.362063707158, 14198.219097949712, 10776.838347424795, 10895.945520272347, 10897.0, 10907.618233361794, 10909.34543927367, 14544.345504452325, 14634.853651463562, 15158.545243642488, 15160.924195378953, 15298.311575978885, 5912.231409916683, 5984.521238300926, 6038.215032045894, 6082.330943596201, 6139.0, 884.0275696733542, 885.9202671759573, 924.8242833861544, 982.9698237227311, 1000.9949950250348, 28016.85991570029, 28378.85810570934, 28620.570691439643, 28658.14025579236, 28936.710632893824, 852.2713080316364, 984.8227319082633, 988.283494466506, 992.0773680477225, 1026.8665073540392, 12777.744445111046, 13372.0, 13382.732345353039, 13465.326733663278, 13589.0, 289004.0, 446603.0, 458138.0, 459905.0, 460417.0, 52631.21053184205, 53238.73380633072, 53327.73336133372, 53598.196027059625, 53731.731341343824, 1105.1379923659558, 1251.6245126462024, 1261.5395380685984, 1285.7299967006845, 1316.782730849399, 27426.314342141606, 29567.556486652287, 29929.102126936228, 30084.84957575198, 30407.0, 38025.0, 38621.4206786904, 38631.0, 38654.61345386622, 39145.6085439142, 198023.0, 198580.0, 199563.0, 199947.0, 199984.0, 26909.596356054284, 31299.84350078235, 31888.0, 32010.35979280355, 32198.356032878743, 36758.69171774553, 39185.95569617064, 39270.21459570735, 39344.80327598344, 40109.398359025225, 33362.33275334528, 33538.496922545695, 33863.153421164665, 34271.485927711605, 34692.132696682784, 33580.66419335873, 33851.15372115717, 33958.15104622404, 34180.14549636279, 34474.482882756274, 33732.83133584316, 33870.66129338675, 34119.82940085284, 34445.655543445246, 34915.12712182114, 29241.707582924748, 30380.392392151593, 30440.39119217559, 30559.847200763856, 30574.388512229187, 24097.51804963856, 25620.743792561836, 26396.8680156598, 27598.0, 27917.0], "unit": "score", "name": "ext.html", "value": 16698.176860641935}, {"lowerIsBetter": false, "replicates": [362.3622424532823, 362.9510016147821, 365.4463487815959, 370.3703703703701, 372.73722025971693, 15402.922985385072, 15640.0, 16857.83142168578, 16865.07242101684, 16899.493015209548, 15547.766783498257, 16045.518634440985, 16136.515904522854, 16168.0, 16181.595460113504, 4905.607551395898, 4959.603231741461, 5112.233165025239, 5121.206213036985, 5126.359205099363, 5047.3438453001245, 5051.1413059779925, 5067.695938243699, 5086.491350864902, 5093.6943783372935, 4917.139500587401, 5087.6184286178495, 5088.0, 5100.591952643779, 5102.438731739506, 5064.746762661852, 5068.087744206042, 5089.770960306758, 5100.209467532539, 5111.361079864998, 4527.864164075083, 4555.385023021916, 4557.726536407826, 4557.886052848672, 4561.1105834362315, 18498.81501184998, 19095.23619055236, 19340.613187736166, 19357.90321048386, 19367.903160484108, 2068.1830676882696, 2073.533454972619, 2074.5332300232476, 2097.224027109979, 2139.752591106652, 12333.506659733599, 12707.301098439582, 12756.80864787029, 13063.216207027514, 13219.272939988297, 1816.4641430777951, 1845.9630807383778, 1862.4505770797512, 1870.1023508715894, 1890.1022014543119, 57653.71173144107, 60064.49193850769, 60252.39747602556, 60541.09188362222, 61044.08433873495, 9519.571619277149, 9568.56941437637, 9928.950355248178, 9972.0, 10085.69742907714, 12547.435365408579, 12720.427580758887, 12774.786395292433, 12805.231686098863, 12816.166949148275, 7488.475806693588, 7519.097708274932, 7547.849043019109, 7595.658195381111, 7604.315611594983, 7315.890261646079, 7370.926290737131, 7381.151167615685, 7395.149557800814, 7454.515456495311, 5941.435563621449, 5965.731542080617, 6032.125341825411, 6105.603135796159, 6115.082737589397, 1732.8873623214452, 1736.0, 1763.1272520102632, 1774.6007148391766, 1778.5020194345345, 625.7371903800415, 889.0975659705405, 956.799072194833, 989.5200827598609, 1010.2776514791959, 15762.374653829454, 15762.842371576138, 15942.0, 16162.838371616133, 16410.1794910254, 895.7402353317595, 897.4301318662566, 905.3526728389234, 926.2358554192817, 940.8682784410188, 9110.453372797654, 9296.070392960784, 9524.952375238217, 9764.316497845224, 9765.560549775277, 407053.0, 416653.0, 426687.0, 429044.0, 438839.0, 68249.0, 73248.63375683088, 75064.24935750682, 75983.62008189924, 76117.23882761212, 967.9370840895319, 973.7614284500202, 989.0603926269929, 997.3018886779283, 998.8301988661945, 14766.114033157615, 14871.702565948404, 14983.351831298767, 15076.246187690353, 15314.157721325435, 36175.63824361723, 36289.637103629684, 36399.0, 36679.26641467209, 37168.814155929045, 44035.77982110069, 45296.773516132205, 50426.49573504218, 50648.49351506438, 51067.0, 7034.929650703428, 7219.314165154512, 7235.710571577289, 7260.318330136832, 7264.891026634499, 8014.519128852287, 9480.905190948002, 10545.261831671709, 10657.680269591925, 10863.402512861869, 9034.548272586477, 9288.210502107397, 9302.441853488812, 9557.187639050759, 9830.361026533252, 8988.235999940078, 9322.580483878106, 9375.109364610624, 9508.477033763209, 9550.092741189575, 9423.0, 9541.666041688508, 9740.707778766648, 9741.366811157252, 9795.314327996972, 7419.629018549159, 7448.217937116525, 7590.354819840375, 7603.619819008917, 7650.2349765023055, 9634.807303853744, 9667.984861589714, 9780.462074585967, 9781.119699227103, 9954.203663706741], "unit": "score", "name": "jquery.html", "value": 8117.791556922413}, {"lowerIsBetter": false, "replicates": [1085.7231405991472, 1422.7367936931669, 1441.805356276903, 1598.8001499812524, 1774.6628140653274, 7273.0908636420445, 7421.81445463863, 7434.1822399536, 7435.665395057222, 7455.552666839993, 7419.0, 7562.2059683733105, 7563.697452101923, 7585.748351521992, 7607.923920760791, 1945.9805401946012, 2249.718785151856, 2287.65685147228, 2302.4128847143957, 2311.6185829338224, 2315.097112126272, 2316.200910685811, 2318.3392733071078, 2319.5708793873187, 2331.405491599648, 2180.2151225558787, 2260.8530445520987, 2266.7166604174477, 2268.9773102269014, 2270.8751018693965, 2281.840271181018, 2316.559853627822, 2318.8956496957676, 2329.9981008166483, 2333.614953532665, 2290.6907567478343, 2295.1966811615966, 2297.115610489957, 2301.7583153768946, 2327.290176496168, 7656.042994625672, 7718.266764657405, 7752.5348479091435, 7753.689852405897, 7753.806154846117, 4659.370984917026, 4796.664233503656, 4805.663603547753, 4810.591099756525, 4811.158047341702, 3030.8787648494035, 3148.2286839724184, 3217.276112874608, 3260.0708797992456, 3265.363254165439, 1013.381837079381, 1015.5582321690089, 1025.318163421324, 1041.7760181560925, 1045.979080418395, 10270.7432314192, 10270.9486452568, 10278.434686092261, 10291.639792607222, 10292.279540432099, 4354.716943398669, 4405.7797110145, 4432.423784907941, 4455.688101832905, 4467.843625473158, 8245.546494942715, 8315.085340612528, 8324.542150181676, 8325.500469971821, 8326.167383261625, 4119.546849846514, 4634.21218392874, 4660.39414876064, 4662.813487460464, 4666.0, 4275.273203555403, 4313.352997050405, 4317.525072242051, 4331.935020974688, 4358.498772641124, 3542.71658267338, 3640.5073919693327, 3649.872254471081, 3681.0, 3690.0774806298427, 1090.378484263962, 1093.3767752381225, 1093.578972095733, 1098.2641630107846, 1100.7688385438987, 1231.58741821489, 1235.0243307786927, 1249.0195196770492, 1251.4994002399112, 1259.0934527140444, 7298.598577078312, 7379.262073792578, 7384.778456646309, 7417.109946806418, 7437.256274372628, 463.59898687635626, 464.83963032753644, 469.1344469453852, 470.60704311899946, 477.9091972525209, 5611.0741727615305, 5614.270144881221, 5627.774889004476, 5632.633878797865, 5677.943220567741, 8991.14584114508, 9135.0, 9333.859992099988, 9444.90555094454, 9447.385919915183, 9081.409708368936, 9180.908190918006, 9239.445633262027, 9259.074092590687, 9261.305402094735, 7072.434205263567, 7108.644567771591, 7122.5726456412785, 7192.892106618405, 7192.964035179791, 6803.217629972616, 6839.31606839332, 6852.45180385558, 6861.862762744618, 6890.276520965427, 7949.880751788844, 8296.128906464975, 8378.790530236549, 8404.789880252798, 8427.283680887193, 8162.591870406574, 8226.506409615442, 8231.0, 8377.874331884905, 8380.24577788002, 5890.293164820249, 6512.5766825156215, 6636.7013484392355, 6658.733650654113, 6751.054852320777, 7189.496735228484, 7194.640267986684, 7216.675249613675, 7241.275872412716, 7247.637618119178, 6362.809115726535, 6564.671766411756, 6572.244191917991, 6664.266930637529, 6670.733170673118, 6612.404883560503, 6642.667866606554, 6658.234303055211, 6659.866802664016, 6706.83232919181, 6962.651867406508, 6981.5461994970165, 7009.894851577128, 7024.8595028098125, 7030.261822508563, 6326.493880489457, 6408.647524386203, 6409.9038514423255, 6481.837954051187, 6483.870322593616, 6473.287938326875, 6481.222253329631, 6505.186851643544, 6532.608043517404, 6540.215174179129], "unit": "score", "name": "mootools.html", "value": 4320.380214255572}, {"lowerIsBetter": false, "replicates": [313.8085767681715, 315.92101974506375, 320.8812739286464, 320.9165616939596, 326.7777911020507, 5218.243354713569, 5408.242846001563, 5414.296141501604, 5418.24144619753, 5427.3215848019, 5249.448807875166, 5347.064263753847, 5349.277847490587, 5365.275687782158, 5367.06076436624, 3876.8836934891997, 3958.5051868516434, 4090.1206240658253, 4132.669386449092, 4134.0, 4109.856155034575, 4121.381792731085, 4127.442795222637, 4130.938035929464, 4132.607402296777, 4062.431259623655, 4068.7965601719943, 4080.0411903202726, 4080.06158583526, 4081.9183616327805, 3905.7461265017682, 3948.5853985331414, 4028.1742242840146, 4085.734427262248, 4087.9386809197886, 3555.9111022224392, 3573.9642603573893, 3574.5889222739456, 3575.624559421249, 3582.140286331288, 5069.264956581312, 5077.898442031175, 5080.74596270185, 5087.236914462823, 5089.54194122527, 4723.811047558093, 4737.289406589005, 4741.0, 4743.0, 4743.667943243974, 5585.944140558583, 5586.441355864422, 5586.553075753971, 5592.468715472064, 5620.494155525981, 3943.0339566806315, 3946.1910308386714, 3950.4469374287623, 3950.703697222691, 3961.9698878291565, 5747.195392645033, 5798.594098413113, 5867.618604790675, 5895.646261224298, 5936.1095835625, 3964.0288129407904, 3966.5835087315995, 3986.362182050858, 3986.5016872890887, 3990.8004599769897, 4046.190761847642, 4046.5751096135073, 4048.7773172475795, 4049.2913740095955, 4052.8986775330854, 4684.2271025281125, 4687.7656117194, 4692.296155576622, 4693.943862630881, 4698.718076915396, 5610.961972035187, 5647.604667673223, 5647.830565083054, 5648.378678345379, 5650.29371328584, 1420.1692010174163, 1442.2428225181654, 1442.8412874583787, 1443.5308524729505, 1444.59551325629, 908.7455512456522, 944.997568020975, 973.5035132082688, 973.5473005052543, 995.999020983921, 4879.292502587176, 4956.083124621957, 4968.329275547755, 4976.527229913152, 4980.078685443204, 5807.303123625192, 5865.325487568899, 5888.352281249059, 5888.735006924699, 5889.440503152194, 4990.426100998359, 4992.400911890596, 4996.325496058058, 4997.750112494361, 5003.224500202475, 3111.719945204897, 3147.716705496516, 3151.416987857254, 3156.210947263184, 3157.0213233897566, 5569.582281328835, 5570.693611851306, 5571.66570005801, 5575.414581468968, 5584.52531534816, 5831.912521312183, 6027.186329845415, 6032.698365081728, 6037.547183961133, 6040.36576159497, 5536.806211782568, 5558.055130627722, 5566.387697353288, 5571.9442805571425, 5573.164025396223, 5869.0, 5869.383714710065, 5871.6183448075735, 5875.735591898289, 5884.146798714248, 5719.342275638355, 5748.827535173951, 5750.913736294043, 5759.596828222152, 5772.567057470623, 5379.1662292344745, 5530.391656917655, 5534.889302214014, 5542.8337149885565, 5543.1408131739645, 4061.1268577256033, 4064.248114098901, 4066.1867626475414, 4066.268071747114, 4067.4102255172243, 5809.5352371811, 5838.065909454467, 5854.443827836349, 5865.354810970704, 5870.236869206976, 5633.295838020247, 5645.71771411436, 5648.830535083954, 5649.887002260014, 5651.88696226065, 5612.158176273591, 5627.296587926509, 5631.774729010794, 5640.717964101696, 5642.6614403135945, 5396.3524377075, 5516.862078448071, 5534.91697624544, 5549.445055494418, 5552.416996215501, 5647.29408823897, 5668.716564171693, 5677.858053548694, 5688.800891968761, 5691.260136182435, 5508.256385387921, 5545.556355491632, 5552.944470555404, 5554.528050066816, 5555.0834112371], "unit": "score", "name": "prototype.html", "value": 4224.966951443912}, {"lowerIsBetter": false, "replicates": [661.2620573590227, 728.2462651156054, 747.8856503809324, 785.9607019649012, 790.671871173463, 14750.0, 15044.924775376108, 15081.321340539675, 15083.396664133421, 15097.547073587797, 14188.787168192459, 14200.289985500734, 14212.076215046014, 14227.857721422783, 14246.857531424683, 655.9639219842907, 806.9475484093545, 815.2621877201112, 831.4512421801612, 832.3590835057003, 814.3241109878816, 817.6034623207769, 821.9054808697017, 823.8311146215011, 824.3034635732796, 862.4868203418956, 870.29071306885, 870.6473878079388, 871.255076909243, 871.3464901324007, 679.9558028728167, 852.0882655558555, 856.4347530629785, 858.4162769316894, 868.7306934850217, 629.6599836088507, 630.2940706408806, 631.2645767680647, 631.381246378547, 631.4001698386505, 13152.079354445194, 13222.404991775393, 13270.668233294246, 13271.86728132716, 13277.46890124394, 12187.51249950001, 12221.083418743541, 12263.570775022921, 12827.10210285271, 12835.550755723598, 10909.509072091696, 11065.225434219608, 11068.335899846035, 11621.24461909973, 11692.707682307926, 3342.9331413371838, 3346.330733853215, 3371.325734853039, 3416.641252668459, 3434.1929646533044, 46046.309305360446, 46120.077598447846, 46196.07607847858, 46678.0, 46680.0, 10017.749556261151, 10050.296479246528, 10098.899011009797, 10185.33795303303, 10296.382217067, 15516.767248491282, 15544.533663990098, 15585.844141558438, 15594.142322172389, 15597.142157181237, 6935.791926242221, 7023.89464158038, 7062.964685176541, 7087.858242835217, 7199.849528787494, 3814.771113733185, 3840.462335273064, 3861.9765762073075, 3875.612438756158, 3926.1755031443145, 2834.1780883543543, 2873.726995935383, 2879.136259122255, 2881.4957382457987, 2882.0345184363473, 500.73961539999, 515.4047075627581, 532.9893402132013, 534.3721127675044, 546.0798554435788, 497.9975100124549, 573.6930742053065, 575.4389470266457, 592.8310431526994, 594.1444320179015, 7022.754203602849, 7116.252793456716, 7344.853102937911, 7362.3741981932135, 7477.027986361738, 459.3018611710182, 508.905852417304, 519.7115600841494, 566.5212895103631, 578.774278031568, 3457.2566898117025, 3527.5766907971206, 3625.4380571011534, 3661.7436779425716, 3693.390590552529, 55630.721846391316, 56068.43931560714, 56099.71950140223, 56163.157552636745, 56271.0, 47258.29112563314, 47644.28533571999, 48187.518124819006, 48201.517984820406, 48432.75783621059, 42226.155476890905, 42309.36535951963, 42447.0, 42500.36249456261, 42520.78739606282, 7231.63841807897, 7373.815654608463, 7444.813879652836, 7456.813579660552, 7457.216992215956, 29526.261843454085, 29790.553141703323, 30481.54277685792, 30614.84692576612, 30643.387132257674, 39720.205595888496, 40574.79712601418, 41024.79487602543, 41076.0, 41293.793531032155, 9159.0, 9367.953160234156, 9411.576479058322, 9511.0, 9615.278854086111, 8717.128287171232, 8784.945806503261, 8797.780055498408, 8839.51382673959, 8976.281897448058, 8968.910310896808, 10383.740406489596, 10511.57953681844, 10633.149348052291, 10825.783484330426, 10158.644447444303, 10239.795204096024, 10249.282550221413, 10446.268761186644, 10793.622223222465, 9936.801263974825, 10126.13927816144, 10289.125424338716, 10423.791524169323, 10487.161027117965, 9134.177923986874, 9218.907810922074, 9343.626254949726, 9571.090746379083, 9695.224382049279, 8885.822283554422, 8948.725577704894, 9145.86281205769, 9164.862527061967, 9202.21781148583], "unit": "score", "name": "yui.html", "value": 5896.880925289491}], "name": "dromaeo_css", "value": 6388.225344841997}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 109.0, 112.0, 112.0, 112.0, 102.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [158.0, 129.0, 150.0, 167.0, 130.0, 151.0, 159.0, 137.0, 177.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 163.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 101.0, 98.0, 72.0, 72.0, 73.0, 112.0, 93.0, 76.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 144.0, 93.0, 93.0, 93.0, 142.0, 94.0, 93.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 148.0, 145.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 63.0, 64.0, 63.0, 64.0, 64.0, 73.0, 61.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 64.3}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 81.0, 82.0, 83.0, 82.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [115.0, 116.0, 112.0, 112.0, 117.0, 116.0, 125.0, 117.0, 122.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.5}, {"lowerIsBetter": true, "replicates": [142.0, 130.0, 142.0, 143.0, 142.0, 128.0, 142.0, 141.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 65.0, 66.0, 67.0, 66.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1504.5}]} 04:49:19 INFO - Return code: 0 04:49:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:49:19 ERROR - # TBPL SUCCESS # 04:49:19 INFO - Running post-action listener: _resource_record_post_action 04:49:19 INFO - Running post-run listener: _resource_record_post_run 04:49:20 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527667200; Read time: 12; Write time: 812796 04:49:20 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 242176000; Read time: 0; Write time: 515188 04:49:20 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284893184; Read time: 12; Write time: 297604 04:49:20 INFO - Running post-run listener: _upload_blobber_files 04:49:20 INFO - Blob upload gear active. 04:49:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:49: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 04:49: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'] 04:49: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 04:49:20 INFO - (blobuploader) - INFO - Open directory for files ... 04:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:21 INFO - (blobuploader) - INFO - Done attempting. 04:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:49:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:22 INFO - (blobuploader) - INFO - Done attempting. 04:49:22 INFO - (blobuploader) - INFO - Iteration through files over. 04:49:22 INFO - Return code: 0 04:49:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:49:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:49:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9551f2627cfb7aef7797a8a0566329951dec2d4f63bd2487e181a086b866578676404c8ad3886e10f25f029851f2a644885b116febc953c856c97b48b70169bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/108be983038b8f7038f54ac1e333827fba0fd3b979073a8f9d08bab183a807469f0eb3f774b531f99852a49e275b4dfe46ceee875482f65ac944cf74d62f1376"} 04:49:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:49:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:49:22 INFO - Contents: 04:49:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9551f2627cfb7aef7797a8a0566329951dec2d4f63bd2487e181a086b866578676404c8ad3886e10f25f029851f2a644885b116febc953c856c97b48b70169bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/108be983038b8f7038f54ac1e333827fba0fd3b979073a8f9d08bab183a807469f0eb3f774b531f99852a49e275b4dfe46ceee875482f65ac944cf74d62f1376"} 04:49:22 INFO - Running post-run listener: copy_logs_to_upload_dir 04:49:22 INFO - Copying logs to upload dir... 04:49:22 INFO - mkdir: /builds/slave/test/build/upload/logs 04:49:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.875378 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-17 04:49:21.801748) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 04:49:21.805419) ========= 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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 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/9551f2627cfb7aef7797a8a0566329951dec2d4f63bd2487e181a086b866578676404c8ad3886e10f25f029851f2a644885b116febc953c856c97b48b70169bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/108be983038b8f7038f54ac1e333827fba0fd3b979073a8f9d08bab183a807469f0eb3f774b531f99852a49e275b4dfe46ceee875482f65ac944cf74d62f1376"} build_url:https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/FWTIGuzPT_KaYJNIqmRFBw/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/9551f2627cfb7aef7797a8a0566329951dec2d4f63bd2487e181a086b866578676404c8ad3886e10f25f029851f2a644885b116febc953c856c97b48b70169bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/108be983038b8f7038f54ac1e333827fba0fd3b979073a8f9d08bab183a807469f0eb3f774b531f99852a49e275b4dfe46ceee875482f65ac944cf74d62f1376"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 04:49:21.834637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:49:21.835401) ========= 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=5bd038846534b2fdfa68eeae000001e2-1458212509.452682-445149595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 04:49:21.918088) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 04:49:21.918571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 04:49:21.918890) ========= ========= Total master_lag: 0.32 =========