builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1458563842.65 results: success (0) buildid: 20160321045436 builduid: ad85d07eaf4d4954bddd9c6ef82069cc revision: 7dfa1b5d26078ed68890fa24fb19c4ade88496aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.645902) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.646374) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.646804) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006374 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.684615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.684938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.860398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.860661) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004651 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.904388) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.904943) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.905302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:22.905573) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-21 05:37:23-- 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% 225M=0s 2016-03-21 05:37:23 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172113 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:23.130249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:23.130521) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017206 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:23.216430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 05:37:23.216781) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7dfa1b5d26078ed68890fa24fb19c4ade88496aa --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 7dfa1b5d26078ed68890fa24fb19c4ade88496aa --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-21 05:37:23,465 truncating revision to first 12 chars 2016-03-21 05:37:23,465 Setting DEBUG logging. 2016-03-21 05:37:23,465 attempt 1/10 2016-03-21 05:37:23,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7dfa1b5d2607?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 05:37:24,734 unpacking tar archive at: fx-team-7dfa1b5d2607/testing/mozharness/ program finished with exit code 0 elapsedTime=1.527691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 05:37:24.761996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:24.762336) ========= echo 7dfa1b5d26078ed68890fa24fb19c4ade88496aa in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7dfa1b5d26078ed68890fa24fb19c4ade88496aa'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7dfa1b5d26078ed68890fa24fb19c4ade88496aa program finished with exit code 0 elapsedTime=0.004245 script_repo_revision: '7dfa1b5d26078ed68890fa24fb19c4ade88496aa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:24.812128) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:24.812465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 05:37:24.822345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-03-21 05:37:24.822673) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:37:25 INFO - MultiFileLogger online at 20160321 05:37:25 in /builds/slave/test 05:37:25 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 05:37:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:37:25 INFO - {'append_to_log': False, 05:37:25 INFO - 'base_work_dir': '/builds/slave/test', 05:37:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:37:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:37:25 INFO - 'branch': 'Fx-Team-Non-PGO', 05:37:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:37:25 INFO - 'config_files': ('talos/linux_config.py',), 05:37:25 INFO - 'default_actions': ('clobber', 05:37:25 INFO - 'read-buildbot-config', 05:37:25 INFO - 'download-and-extract', 05:37:25 INFO - 'populate-webroot', 05:37:25 INFO - 'create-virtualenv', 05:37:25 INFO - 'install', 05:37:25 INFO - 'run-tests'), 05:37:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:37:25 INFO - 'download_minidump_stackwalk': True, 05:37:25 INFO - 'download_symbols': 'ondemand', 05:37:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:37:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:37:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:37:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:37:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:37:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:37:25 INFO - 'installer_path': 'installer.exe', 05:37:25 INFO - 'log_level': 'info', 05:37:25 INFO - 'log_name': 'talos', 05:37:25 INFO - 'log_to_console': True, 05:37:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:37:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:37:25 INFO - 'opt_config_files': (), 05:37:25 INFO - 'pip_index': False, 05:37:25 INFO - 'sps_profile': False, 05:37:25 INFO - 'sps_profile_interval': 0, 05:37:25 INFO - 'suite': 'dromaeojs', 05:37:25 INFO - 'system_bits': '32', 05:37:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:37:25 INFO - 'title': 'talos-linux64-ix-065', 05:37:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:37:25 INFO - 'use_talos_json': True, 05:37:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:37:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:37:25 INFO - 'work_dir': 'build'} 05:37:25 INFO - ##### 05:37:25 INFO - ##### Running clobber step. 05:37:25 INFO - ##### 05:37:25 INFO - Running pre-action listener: _resource_record_pre_action 05:37:25 INFO - Running main action method: clobber 05:37:25 INFO - rmtree: /builds/slave/test/build 05:37:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:37:26 INFO - Running post-action listener: _resource_record_post_action 05:37:26 INFO - ##### 05:37:26 INFO - ##### Running read-buildbot-config step. 05:37:26 INFO - ##### 05:37:26 INFO - Running pre-action listener: _resource_record_pre_action 05:37:26 INFO - Running main action method: read_buildbot_config 05:37:26 INFO - Using buildbot properties: 05:37:26 INFO - { 05:37:26 INFO - "project": "", 05:37:26 INFO - "product": "firefox", 05:37:26 INFO - "script_repo_revision": "production", 05:37:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:37:26 INFO - "repository": "", 05:37:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:37:26 INFO - "buildid": "20160321045436", 05:37:26 INFO - "pgo_build": "False", 05:37:26 INFO - "basedir": "/builds/slave/test", 05:37:26 INFO - "buildnumber": 2667, 05:37:26 INFO - "slavename": "talos-linux64-ix-065", 05:37:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:37:26 INFO - "platform": "ubuntu64_hw", 05:37:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:37:26 INFO - "branch": "fx-team", 05:37:26 INFO - "repo_path": "integration/fx-team", 05:37:26 INFO - "revision": "7dfa1b5d26078ed68890fa24fb19c4ade88496aa", 05:37:26 INFO - "stage_platform": "linux64", 05:37:26 INFO - "builduid": "ad85d07eaf4d4954bddd9c6ef82069cc", 05:37:26 INFO - "slavebuilddir": "test" 05:37:26 INFO - } 05:37:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:37:26 INFO - Running post-action listener: _resource_record_post_action 05:37:26 INFO - ##### 05:37:26 INFO - ##### Running download-and-extract step. 05:37:26 INFO - ##### 05:37:26 INFO - Running pre-action listener: _resource_record_pre_action 05:37:26 INFO - Running main action method: download_and_extract 05:37:26 INFO - mkdir: /builds/slave/test/build/tests 05:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:26 INFO - https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:37:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:37:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:37:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:35 INFO - Downloaded 1361 bytes. 05:37:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:37:35 INFO - Using the following test package requirements: 05:37:35 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:37:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:37:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:35 INFO - u'jsshell-linux-x86_64.zip'], 05:37:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:37:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:37:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:37:35 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:37:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:37:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:37:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:37:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:35 INFO - https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:37:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:37:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:39 INFO - Downloaded 21999954 bytes. 05:37:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:37:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:37:41 INFO - Return code: 0 05:37:41 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 05:37:41 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')]} 05:37:41 INFO - https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:43 INFO - Downloaded 21999954 bytes. 05:37:43 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'] 05:37:43 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 05:37:45 INFO - Return code: 0 05:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:45 INFO - https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:47 INFO - Downloaded 10847637 bytes. 05:37:47 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'] 05:37:47 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 05:37:47 INFO - Return code: 0 05:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:47 INFO - https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f9LpAThhRfeTHzvz5HJa5w/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 05:37:49 INFO - Downloaded 54155918 bytes. 05:37:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:37:49 INFO - mkdir: /builds/slave/test/properties 05:37:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:37:49 INFO - Writing to file /builds/slave/test/properties/build_url 05:37:49 INFO - Contents: 05:37:49 INFO - build_url:https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:37:50 INFO - Running post-action listener: _resource_record_post_action 05:37:50 INFO - Running post-action listener: set_extra_try_arguments 05:37:50 INFO - ##### 05:37:50 INFO - ##### Running populate-webroot step. 05:37:50 INFO - ##### 05:37:50 INFO - Running pre-action listener: _resource_record_pre_action 05:37:50 INFO - Running main action method: populate_webroot 05:37:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:37:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:37:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:37:50 INFO - '--tppagecycles', 05:37:50 INFO - '7'], 05:37:50 INFO - 'tests': ['tsvgm']}}, 05:37:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:37:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:37:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:37:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:37:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:50 INFO - 'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:37:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:50 INFO - 'tests': ['damp', 'tps']}, 05:37:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:50 INFO - 'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['damp', 'tps']}, 05:37:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:37:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:37:50 INFO - 'other': {'tests': ['a11yr', 05:37:50 INFO - 'ts_paint', 05:37:50 INFO - 'tpaint', 05:37:50 INFO - 'sessionrestore', 05:37:50 INFO - 'sessionrestore_no_auto_restore', 05:37:50 INFO - 'tabpaint']}, 05:37:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['a11yr', 05:37:50 INFO - 'ts_paint', 05:37:50 INFO - 'tpaint', 05:37:50 INFO - 'sessionrestore', 05:37:50 INFO - 'sessionrestore_no_auto_restore', 05:37:50 INFO - 'tabpaint']}, 05:37:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['a11yr', 05:37:50 INFO - 'ts_paint', 05:37:50 INFO - 'tpaint', 05:37:50 INFO - 'sessionrestore', 05:37:50 INFO - 'sessionrestore_no_auto_restore', 05:37:50 INFO - 'tabpaint']}, 05:37:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['a11yr', 05:37:50 INFO - 'ts_paint', 05:37:50 INFO - 'tpaint', 05:37:50 INFO - 'sessionrestore', 05:37:50 INFO - 'sessionrestore_no_auto_restore', 05:37:50 INFO - 'tabpaint']}, 05:37:50 INFO - 'other_l64': {'tests': ['a11yr', 05:37:50 INFO - 'ts_paint', 05:37:50 INFO - 'tpaint', 05:37:50 INFO - 'sessionrestore', 05:37:50 INFO - 'sessionrestore_no_auto_restore', 05:37:50 INFO - 'tabpaint']}, 05:37:50 INFO - 'other_nol64': {'tests': ['a11yr', 05:37:50 INFO - 'ts_paint', 05:37:50 INFO - 'tpaint', 05:37:50 INFO - 'sessionrestore', 05:37:50 INFO - 'sessionrestore_no_auto_restore', 05:37:50 INFO - 'tabpaint']}, 05:37:50 INFO - 'svgr': {'tests': ['tsvgx', 05:37:50 INFO - 'tsvgr_opacity', 05:37:50 INFO - 'tart', 05:37:50 INFO - 'tscrollx', 05:37:50 INFO - 'cart']}, 05:37:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['tsvgx', 05:37:50 INFO - 'tsvgr_opacity', 05:37:50 INFO - 'tart', 05:37:50 INFO - 'tscrollx', 05:37:50 INFO - 'cart']}, 05:37:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:50 INFO - 'tests': ['tp5o']}, 05:37:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:50 INFO - 'talos_options': ['--e10s'], 05:37:50 INFO - 'tests': ['tp5o']}, 05:37:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:50 INFO - 'talos_options': ['--xperf_path', 05:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:50 INFO - 'tests': ['tp5n']}, 05:37:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:37:50 INFO - 'talos_options': ['--e10s', 05:37:50 INFO - '--xperf_path', 05:37:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:37:50 INFO - 'tests': ['tp5n']}}, 05:37:50 INFO - 'talos.zip': {'path': '', 05:37:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:37:50 INFO - Running post-action listener: _resource_record_post_action 05:37:50 INFO - ##### 05:37:50 INFO - ##### Running create-virtualenv step. 05:37:50 INFO - ##### 05:37:50 INFO - Running pre-action listener: _resource_record_pre_action 05:37:50 INFO - Running main action method: create_virtualenv 05:37:50 INFO - Creating virtualenv /builds/slave/test/build/venv 05:37:50 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 05:37:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:37:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:37:50 INFO - Using real prefix '/usr' 05:37:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:37:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:37:52 INFO - Installing pip.................done. 05:37:52 INFO - Return code: 0 05:37:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:37:52 INFO - Using env: {'DISPLAY': ':0', 05:37:52 INFO - 'HOME': '/home/cltbld', 05:37:52 INFO - 'LANG': 'en_US.UTF-8', 05:37:52 INFO - 'LANGUAGE': 'en_US:en', 05:37:52 INFO - 'LOGNAME': 'cltbld', 05:37:52 INFO - 'MAIL': '/var/mail/cltbld', 05:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:52 INFO - 'MOZ_NO_REMOTE': '1', 05:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:52 INFO - 'NO_EM_RESTART': '1', 05:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:52 INFO - 'PWD': '/builds/slave/test', 05:37:52 INFO - 'SHELL': '/bin/bash', 05:37:52 INFO - 'SHLVL': '1', 05:37:52 INFO - 'TERM': 'linux', 05:37:52 INFO - 'TMOUT': '86400', 05:37:52 INFO - 'USER': 'cltbld', 05:37:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:52 INFO - '_': '/tools/buildbot/bin/python'} 05:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:53 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 05:37:53 INFO - Cleaning up... 05:37:53 INFO - Return code: 0 05:37:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:37:53 INFO - Using env: {'DISPLAY': ':0', 05:37:53 INFO - 'HOME': '/home/cltbld', 05:37:53 INFO - 'LANG': 'en_US.UTF-8', 05:37:53 INFO - 'LANGUAGE': 'en_US:en', 05:37:53 INFO - 'LOGNAME': 'cltbld', 05:37:53 INFO - 'MAIL': '/var/mail/cltbld', 05:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:53 INFO - 'MOZ_NO_REMOTE': '1', 05:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:53 INFO - 'NO_EM_RESTART': '1', 05:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:53 INFO - 'PWD': '/builds/slave/test', 05:37:53 INFO - 'SHELL': '/bin/bash', 05:37:53 INFO - 'SHLVL': '1', 05:37:53 INFO - 'TERM': 'linux', 05:37:53 INFO - 'TMOUT': '86400', 05:37:53 INFO - 'USER': 'cltbld', 05:37:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:53 INFO - '_': '/tools/buildbot/bin/python'} 05:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:53 INFO - Downloading/unpacking psutil>=0.7.1 05:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:55 INFO - Installing collected packages: psutil 05:37:55 INFO - Running setup.py install for psutil 05:37:55 INFO - building 'psutil._psutil_linux' extension 05:37:55 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 05:37:55 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 05:37:55 INFO - building 'psutil._psutil_posix' extension 05:37:55 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 05:37:55 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 05:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:37:55 INFO - Successfully installed psutil 05:37:55 INFO - Cleaning up... 05:37:55 INFO - Return code: 0 05:37:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:37:55 INFO - Using env: {'DISPLAY': ':0', 05:37:55 INFO - 'HOME': '/home/cltbld', 05:37:55 INFO - 'LANG': 'en_US.UTF-8', 05:37:55 INFO - 'LANGUAGE': 'en_US:en', 05:37:55 INFO - 'LOGNAME': 'cltbld', 05:37:55 INFO - 'MAIL': '/var/mail/cltbld', 05:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:55 INFO - 'MOZ_NO_REMOTE': '1', 05:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:55 INFO - 'NO_EM_RESTART': '1', 05:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:55 INFO - 'PWD': '/builds/slave/test', 05:37:55 INFO - 'SHELL': '/bin/bash', 05:37:55 INFO - 'SHLVL': '1', 05:37:55 INFO - 'TERM': 'linux', 05:37:55 INFO - 'TMOUT': '86400', 05:37:55 INFO - 'USER': 'cltbld', 05:37:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:55 INFO - '_': '/tools/buildbot/bin/python'} 05:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:37:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:37:57 INFO - Installing collected packages: mozsystemmonitor 05:37:57 INFO - Running setup.py install for mozsystemmonitor 05:37:57 INFO - Successfully installed mozsystemmonitor 05:37:57 INFO - Cleaning up... 05:37:58 INFO - Return code: 0 05:37:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:58 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 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:37:58 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 05:37:58 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 05:37:58 INFO - Using env: {'DISPLAY': ':0', 05:37:58 INFO - 'HOME': '/home/cltbld', 05:37:58 INFO - 'LANG': 'en_US.UTF-8', 05:37:58 INFO - 'LANGUAGE': 'en_US:en', 05:37:58 INFO - 'LOGNAME': 'cltbld', 05:37:58 INFO - 'MAIL': '/var/mail/cltbld', 05:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:58 INFO - 'MOZ_NO_REMOTE': '1', 05:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:58 INFO - 'NO_EM_RESTART': '1', 05:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:58 INFO - 'PWD': '/builds/slave/test', 05:37:58 INFO - 'SHELL': '/bin/bash', 05:37:58 INFO - 'SHLVL': '1', 05:37:58 INFO - 'TERM': 'linux', 05:37:58 INFO - 'TMOUT': '86400', 05:37:58 INFO - 'USER': 'cltbld', 05:37:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:58 INFO - '_': '/tools/buildbot/bin/python'} 05:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:58 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 05:37:58 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 05:37:58 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 05:37:58 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 05:37:58 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 05:37:58 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 05:38:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:38:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:38:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:00 INFO - Downloading docopt-0.6.1.tar.gz 05:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:38:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:38:00 INFO - Running setup.py install for blobuploader 05:38:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:38:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:38:00 INFO - Running setup.py install for requests 05:38:01 INFO - Running setup.py install for docopt 05:38:01 INFO - Successfully installed blobuploader requests docopt 05:38:01 INFO - Cleaning up... 05:38:01 INFO - Return code: 0 05:38:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:01 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 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:38:01 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 05:38:01 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 05:38:01 INFO - Using env: {'DISPLAY': ':0', 05:38:01 INFO - 'HOME': '/home/cltbld', 05:38:01 INFO - 'LANG': 'en_US.UTF-8', 05:38:01 INFO - 'LANGUAGE': 'en_US:en', 05:38:01 INFO - 'LOGNAME': 'cltbld', 05:38:01 INFO - 'MAIL': '/var/mail/cltbld', 05:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:01 INFO - 'MOZ_NO_REMOTE': '1', 05:38:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:01 INFO - 'NO_EM_RESTART': '1', 05:38:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:01 INFO - 'PWD': '/builds/slave/test', 05:38:01 INFO - 'SHELL': '/bin/bash', 05:38:01 INFO - 'SHLVL': '1', 05:38:01 INFO - 'TERM': 'linux', 05:38:01 INFO - 'TMOUT': '86400', 05:38:01 INFO - 'USER': 'cltbld', 05:38:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:01 INFO - '_': '/tools/buildbot/bin/python'} 05:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:01 INFO - Running setup.py (path:/tmp/pip-eYn1yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:01 INFO - Running setup.py (path:/tmp/pip-pY3AA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:01 INFO - Running setup.py (path:/tmp/pip-apLEtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:01 INFO - Running setup.py (path:/tmp/pip-z0Mkqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:01 INFO - Running setup.py (path:/tmp/pip-CfzN6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:01 INFO - Running setup.py (path:/tmp/pip-bMELQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:02 INFO - Running setup.py (path:/tmp/pip-5Xzqku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:02 INFO - Running setup.py (path:/tmp/pip-njnMMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:02 INFO - Running setup.py (path:/tmp/pip-UAac4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:02 INFO - Running setup.py (path:/tmp/pip-pLFoEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:02 INFO - Running setup.py (path:/tmp/pip-3SJFam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:02 INFO - Running setup.py (path:/tmp/pip-yjWIOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:02 INFO - Running setup.py (path:/tmp/pip-pvkhwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:02 INFO - Running setup.py (path:/tmp/pip-gDqW3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:02 INFO - Running setup.py (path:/tmp/pip-CbfGP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:02 INFO - Running setup.py (path:/tmp/pip-C9eNQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:02 INFO - Running setup.py (path:/tmp/pip-Idc6xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:38:02 INFO - Running setup.py install for manifestparser 05:38:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Running setup.py install for mozcrash 05:38:03 INFO - Running setup.py install for mozdebug 05:38:03 INFO - Running setup.py install for mozdevice 05:38:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Running setup.py install for mozfile 05:38:03 INFO - Running setup.py install for mozhttpd 05:38:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Running setup.py install for mozinfo 05:38:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Running setup.py install for mozInstall 05:38:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:38:03 INFO - Running setup.py install for mozleak 05:38:03 INFO - Running setup.py install for mozlog 05:38:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:38:04 INFO - Running setup.py install for moznetwork 05:38:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:38:04 INFO - Running setup.py install for mozprocess 05:38:04 INFO - Running setup.py install for mozprofile 05:38:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:38:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:38:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:38:04 INFO - Running setup.py install for mozrunner 05:38:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:38:04 INFO - Running setup.py install for mozscreenshot 05:38:04 INFO - Running setup.py install for moztest 05:38:04 INFO - Running setup.py install for mozversion 05:38:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:38:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:38:04 INFO - Cleaning up... 05:38:04 INFO - Return code: 0 05:38:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:04 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')]} 05:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:04 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')]} 05:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:04 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 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:38:04 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 05:38:04 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 05:38:04 INFO - Using env: {'DISPLAY': ':0', 05:38:04 INFO - 'HOME': '/home/cltbld', 05:38:04 INFO - 'LANG': 'en_US.UTF-8', 05:38:04 INFO - 'LANGUAGE': 'en_US:en', 05:38:04 INFO - 'LOGNAME': 'cltbld', 05:38:04 INFO - 'MAIL': '/var/mail/cltbld', 05:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:04 INFO - 'MOZ_NO_REMOTE': '1', 05:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:04 INFO - 'NO_EM_RESTART': '1', 05:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:04 INFO - 'PWD': '/builds/slave/test', 05:38:04 INFO - 'SHELL': '/bin/bash', 05:38:04 INFO - 'SHLVL': '1', 05:38:04 INFO - 'TERM': 'linux', 05:38:04 INFO - 'TMOUT': '86400', 05:38:04 INFO - 'USER': 'cltbld', 05:38:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:04 INFO - '_': '/tools/buildbot/bin/python'} 05:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:38:05 INFO - Running setup.py (path:/tmp/pip-qS09VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:38:05 INFO - Running setup.py (path:/tmp/pip-ha3TPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:38:05 INFO - Running setup.py (path:/tmp/pip-3ykhjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:38:05 INFO - Running setup.py (path:/tmp/pip-jFody8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:38:05 INFO - Running setup.py (path:/tmp/pip-V33RkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:38:05 INFO - Running setup.py (path:/tmp/pip-XTjRZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:38:05 INFO - Running setup.py (path:/tmp/pip-pnF9Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:38:05 INFO - Running setup.py (path:/tmp/pip-7LAJLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:38:05 INFO - Running setup.py (path:/tmp/pip-oUKrh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:38:05 INFO - Running setup.py (path:/tmp/pip-X2TYvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:38:05 INFO - Running setup.py (path:/tmp/pip-rGTx7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:38:05 INFO - Running setup.py (path:/tmp/pip-DdHQfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:38:05 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)) 05:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:38:05 INFO - Running setup.py (path:/tmp/pip-fYHyPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:38:06 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)) 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:38:06 INFO - Running setup.py (path:/tmp/pip-f0rSjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:38:06 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)) 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:06 INFO - Running setup.py (path:/tmp/pip-735YlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:38:06 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)) 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:38:06 INFO - Running setup.py (path:/tmp/pip-7IcnyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:38:06 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)) 05:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:38:06 INFO - Running setup.py (path:/tmp/pip-CfQioI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:38:06 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)) 05:38:06 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)) 05:38:06 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)) 05:38:06 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)) 05:38:06 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)) 05:38:06 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)) 05:38:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38: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 05:38:08 INFO - Downloading blessings-1.6.tar.gz 05:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:38:08 INFO - Installing collected packages: blessings 05:38:08 INFO - Running setup.py install for blessings 05:38:08 INFO - Successfully installed blessings 05:38:08 INFO - Cleaning up... 05:38:08 INFO - Return code: 0 05:38:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:38:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:08 INFO - Reading from file tmpfile_stdout 05:38:08 INFO - Current package versions: 05:38:08 INFO - argparse == 1.2.1 05:38:08 INFO - blessings == 1.6 05:38:08 INFO - blobuploader == 1.2.4 05:38:08 INFO - docopt == 0.6.1 05:38:08 INFO - manifestparser == 1.1 05:38:08 INFO - mozInstall == 1.12 05:38:08 INFO - mozcrash == 0.17 05:38:08 INFO - mozdebug == 0.1 05:38:08 INFO - mozdevice == 0.48 05:38:08 INFO - mozfile == 1.2 05:38:08 INFO - mozhttpd == 0.7 05:38:08 INFO - mozinfo == 0.9 05:38:08 INFO - mozleak == 0.1 05:38:08 INFO - mozlog == 3.1 05:38:08 INFO - moznetwork == 0.27 05:38:08 INFO - mozprocess == 0.22 05:38:08 INFO - mozprofile == 0.28 05:38:08 INFO - mozrunner == 6.11 05:38:08 INFO - mozscreenshot == 0.1 05:38:08 INFO - mozsystemmonitor == 0.0 05:38:08 INFO - moztest == 0.7 05:38:08 INFO - mozversion == 1.4 05:38:08 INFO - psutil == 3.1.1 05:38:08 INFO - requests == 1.2.3 05:38:08 INFO - wsgiref == 0.1.2 05:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:08 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 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:38:08 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 05:38:08 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 05:38:08 INFO - Using env: {'DISPLAY': ':0', 05:38:08 INFO - 'HOME': '/home/cltbld', 05:38:08 INFO - 'LANG': 'en_US.UTF-8', 05:38:08 INFO - 'LANGUAGE': 'en_US:en', 05:38:08 INFO - 'LOGNAME': 'cltbld', 05:38:08 INFO - 'MAIL': '/var/mail/cltbld', 05:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:08 INFO - 'MOZ_NO_REMOTE': '1', 05:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:08 INFO - 'NO_EM_RESTART': '1', 05:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:08 INFO - 'PWD': '/builds/slave/test', 05:38:08 INFO - 'SHELL': '/bin/bash', 05:38:08 INFO - 'SHLVL': '1', 05:38:08 INFO - 'TERM': 'linux', 05:38:08 INFO - 'TMOUT': '86400', 05:38:08 INFO - 'USER': 'cltbld', 05:38:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:08 INFO - '_': '/tools/buildbot/bin/python'} 05:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 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)) 05:38:08 INFO - Cleaning up... 05:38:08 INFO - Return code: 0 05:38:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:38:08 INFO - Using env: {'DISPLAY': ':0', 05:38:08 INFO - 'HOME': '/home/cltbld', 05:38:08 INFO - 'LANG': 'en_US.UTF-8', 05:38:08 INFO - 'LANGUAGE': 'en_US:en', 05:38:08 INFO - 'LOGNAME': 'cltbld', 05:38:08 INFO - 'MAIL': '/var/mail/cltbld', 05:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:08 INFO - 'MOZ_NO_REMOTE': '1', 05:38:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:08 INFO - 'NO_EM_RESTART': '1', 05:38:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:08 INFO - 'PWD': '/builds/slave/test', 05:38:08 INFO - 'SHELL': '/bin/bash', 05:38:08 INFO - 'SHLVL': '1', 05:38:08 INFO - 'TERM': 'linux', 05:38:08 INFO - 'TMOUT': '86400', 05:38:08 INFO - 'USER': 'cltbld', 05:38:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:08 INFO - '_': '/tools/buildbot/bin/python'} 05:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:09 INFO - Downloading/unpacking jsonschema 05:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:38:10 INFO - Downloading/unpacking functools32 (from jsonschema) 05:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:38:11 INFO - warning: no files found matching '*.txt' 05:38:11 INFO - no previously-included directories found matching 'build' 05:38:11 INFO - no previously-included directories found matching 'dist' 05:38:11 INFO - no previously-included directories found matching '.git*' 05:38:11 INFO - Installing collected packages: jsonschema, functools32 05:38:11 INFO - Running setup.py install for functools32 05:38:11 INFO - warning: no files found matching '*.txt' 05:38:11 INFO - no previously-included directories found matching 'build' 05:38:11 INFO - no previously-included directories found matching 'dist' 05:38:11 INFO - no previously-included directories found matching '.git*' 05:38:11 INFO - Successfully installed jsonschema functools32 05:38:11 INFO - Cleaning up... 05:38:11 INFO - Return code: 0 05:38:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:11 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 0x7fae2e1f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', '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 05:38:11 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 05:38:11 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 05:38:11 INFO - Using env: {'DISPLAY': ':0', 05:38:11 INFO - 'HOME': '/home/cltbld', 05:38:11 INFO - 'LANG': 'en_US.UTF-8', 05:38:11 INFO - 'LANGUAGE': 'en_US:en', 05:38:11 INFO - 'LOGNAME': 'cltbld', 05:38:11 INFO - 'MAIL': '/var/mail/cltbld', 05:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:11 INFO - 'MOZ_NO_REMOTE': '1', 05:38:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:11 INFO - 'NO_EM_RESTART': '1', 05:38:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:11 INFO - 'PWD': '/builds/slave/test', 05:38:11 INFO - 'SHELL': '/bin/bash', 05:38:11 INFO - 'SHLVL': '1', 05:38:11 INFO - 'TERM': 'linux', 05:38:11 INFO - 'TMOUT': '86400', 05:38:11 INFO - 'USER': 'cltbld', 05:38:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:11 INFO - '_': '/tools/buildbot/bin/python'} 05:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:11 INFO - Downloading/unpacking flake8 05:38:11 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 05:38:11 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 05:38:11 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 05:38:11 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 05:38:11 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 05:38:11 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 05:38:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:38:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:38:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:14 INFO - no previously-included directories found matching 'docs/_build' 05:38:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:38:14 INFO - Running setup.py install for pep8 05:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:38:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:38:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:38:14 INFO - no previously-included directories found matching 'docs/_build' 05:38:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:38:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:38:14 INFO - Cleaning up... 05:38:14 INFO - Return code: 0 05:38:14 INFO - Running post-action listener: _resource_record_post_action 05:38:14 INFO - Running post-action listener: _start_resource_monitoring 05:38:14 INFO - Starting resource monitoring. 05:38:14 INFO - ##### 05:38:14 INFO - ##### Running install step. 05:38:14 INFO - ##### 05:38:14 INFO - Running pre-action listener: _resource_record_pre_action 05:38:14 INFO - Running main action method: install 05:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:38:14 INFO - Reading from file tmpfile_stdout 05:38:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:38:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:38:14 INFO - Reading from file tmpfile_stdout 05:38:14 INFO - Output received: 05:38:14 INFO - Usage: mozinstall [options] installer 05:38:14 INFO - Options: 05:38:14 INFO - -h, --help show this help message and exit 05:38:14 INFO - -d DEST, --destination=DEST 05:38:14 INFO - Directory to install application into. [default: 05:38:14 INFO - "/builds/slave/test"] 05:38:14 INFO - --app=APP Application being installed. [default: firefox] 05:38:14 INFO - mkdir: /builds/slave/test/build/application 05:38:14 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'] 05:38:14 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 05:38:30 INFO - Reading from file tmpfile_stdout 05:38:30 INFO - Output received: 05:38:30 INFO - /builds/slave/test/build/application/firefox/firefox 05:38:30 INFO - Running post-action listener: _resource_record_post_action 05:38:30 INFO - ##### 05:38:30 INFO - ##### Running run-tests step. 05:38:30 INFO - ##### 05:38:30 INFO - Running pre-action listener: _resource_record_pre_action 05:38:30 INFO - Running main action method: run_tests 05:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:38:30 INFO - Python 2.7.3 05:38:30 INFO - Return code: 0 05:38:30 INFO - grabbing minidump binary from tooltool 05:38:30 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')]} 05:38:30 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 0x1948410>, '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 0x1949310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19497a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:38:30 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 05:38:30 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 05:38:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:38:30 INFO - Return code: 0 05:38:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:38:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:38:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:38:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:38:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:38:31 INFO - Return code: 0 05:38:31 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/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:38:31 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/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:38:31 INFO - Using env: {'DISPLAY': ':0', 05:38:31 INFO - 'HOME': '/home/cltbld', 05:38:31 INFO - 'LANG': 'en_US.UTF-8', 05:38:31 INFO - 'LANGUAGE': 'en_US:en', 05:38:31 INFO - 'LOGNAME': 'cltbld', 05:38:31 INFO - 'MAIL': '/var/mail/cltbld', 05:38:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:38:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:31 INFO - 'MOZ_NO_REMOTE': '1', 05:38:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:31 INFO - 'NO_EM_RESTART': '1', 05:38:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:31 INFO - 'PWD': '/builds/slave/test', 05:38:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:38:31 INFO - 'SHELL': '/bin/bash', 05:38:31 INFO - 'SHLVL': '1', 05:38:31 INFO - 'TERM': 'linux', 05:38:31 INFO - 'TMOUT': '86400', 05:38:31 INFO - 'USER': 'cltbld', 05:38:31 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070', 05:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:31 INFO - '_': '/tools/buildbot/bin/python'} 05:38:31 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/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:38:31 INFO - mozversion application_buildid: 20160321045436 05:38:31 INFO - mozversion application_changeset: 7dfa1b5d26078ed68890fa24fb19c4ade88496aa 05:38:31 INFO - mozversion application_display_name: Nightly 05:38:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:38:31 INFO - mozversion application_name: Firefox 05:38:31 INFO - mozversion application_remotingname: firefox 05:38:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:38:31 INFO - mozversion application_vendor: Mozilla 05:38:31 INFO - mozversion application_version: 48.0a1 05:38:31 INFO - mozversion platform_buildid: 20160321045436 05:38:31 INFO - mozversion platform_changeset: 7dfa1b5d26078ed68890fa24fb19c4ade88496aa 05:38:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:38:31 INFO - mozversion platform_version: 48.0a1 05:38:31 INFO - using testdate: 1458563911 05:38:31 INFO - actual date: 1458563911 05:38:31 INFO - starting webserver on 'localhost:59450' 05:38:31 INFO - SUITE-START | Running 2 tests 05:38:31 INFO - TEST-START | dromaeo_css 05:38:31 INFO - operating with platform_type : linux_ 05:38:31 INFO - Initialising browser for dromaeo_css test... 05:38:31 INFO - TEST-INFO | started process 29133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYpJN_/profile http://localhost:59450/getInfo.html) 05:38:35 INFO - PROCESS | 29133 | __metrics Screen width/height:1600/1200 05:38:35 INFO - PROCESS | 29133 | colorDepth:24 05:38:35 INFO - PROCESS | 29133 | Browser inner width/height: 1024/697 05:38:35 INFO - PROCESS | 29133 | __metrics 05:38:36 ERROR - PROCESS | 29133 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:38:36 INFO - PROCESS | 29133 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:38:37 INFO - TEST-INFO | 29133: exit 0 05:38:37 INFO - Browser initialized. 05:38:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:38:37 INFO - TEST-INFO | started process 29228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCYpJN_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:49 INFO - PROCESS | 29228 | RSS: Main: 157503488 05:38:49 INFO - PROCESS | 29228 | 05:39:40 INFO - PROCESS | 29228 | 1458563980753 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] 05:41:52 INFO - PROCESS | 29228 | Cycle 1(1): loaded http://localhost:59450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59450/tests/dromaeo/cssquery-ext.html) 05:41:53 INFO - PROCESS | 29228 | RSS: Main: 243666944 05:41:53 INFO - PROCESS | 29228 | 05:44:55 INFO - PROCESS | 29228 | Cycle 1(1): loaded http://localhost:59450/tests/dromaeo/cssquery-ext.html (next: http://localhost:59450/tests/dromaeo/cssquery-jquery.html) 05:44:56 INFO - PROCESS | 29228 | RSS: Main: 235782144 05:44:56 INFO - PROCESS | 29228 | 05:47:58 INFO - PROCESS | 29228 | Cycle 1(1): loaded http://localhost:59450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59450/tests/dromaeo/cssquery-mootools.html) 05:47:58 INFO - PROCESS | 29228 | RSS: Main: 231809024 05:47:58 INFO - PROCESS | 29228 | 05:51:00 INFO - PROCESS | 29228 | Cycle 1(1): loaded http://localhost:59450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59450/tests/dromaeo/cssquery-prototype.html) 05:51:01 INFO - PROCESS | 29228 | RSS: Main: 220008448 05:51:01 INFO - PROCESS | 29228 | 05:54:03 INFO - PROCESS | 29228 | Cycle 1(1): loaded http://localhost:59450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59450/tests/dromaeo/cssquery-yui.html) 05:54:04 INFO - PROCESS | 29228 | RSS: Main: 204922880 05:54:04 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | Cycle 1(1): loaded http://localhost:59450/tests/dromaeo/cssquery-yui.html (next: http://localhost:59450/tests/dromaeo/cssquery-dojo.html) 05:57:07 INFO - PROCESS | 29228 | RSS: Main: 296947712 05:57:07 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | __start_tp_report 05:57:07 INFO - PROCESS | 29228 | _x_x_mozilla_page_load 05:57:07 INFO - PROCESS | 29228 | _x_x_mozilla_page_load_details 05:57:07 INFO - PROCESS | 29228 | |i|pagename|runs| 05:57:07 INFO - PROCESS | 29228 | |0;dojo.html;2615.869206539673;2679.1560658392605;2682.155121136842;2698.7301269873;2717.687465941416;4609.6081833044145;4694.765261736912;4702.6002789762915;4703.153432382174;4720.952790472094;4715.811367545302;4717.363155973942;4746.62027037837;4746.762661866902;4753;4269.295566231568;4331.826726930919;4352.891177720567;4397.758123303217;4415.646748260147;4241.533431322552;4294.978525107385;4369.3227549729845;4381.53993830648;4390.385346051556;4291.549387314334;4338.783060846945;4361.084172323815;4399.142167277382;4400.3399490076745;4319.352097185416;4326.870193894189;4328.696991210617;4361.214981303364;4362.563743625644;4222.535521092677;4266.616004559604;4309.82760689572;4316.892077698083;4338.349247612852;4629.560191781776;4683.695559788603;4684.508126646721;4687.437507499088;4733.0533893221145;5058.342415486;5058.620603454756;5061.620378471629;5062.670926389773;5064.721440320781;4946.826861059845;4973.278874563204;5047.268146118829;5089.541941225308;5099.923501147486;4743.976280118577;4756.667033307635;4759.333693282943;4762.833300834454;4790.185668436374;5192.039472697563;5205.9219111713355;5208.609354298443;5262.631615786935;5271.920921186109;4834.830780922651;4953.2074868020945;5012.498750125032;5037.168867136955;5044.873878153002;5023.623228257895;5031.723255220924;5038.345015148007;5040.571551418097;5094.541491265803;4998.300237966688;5003.974980125076;5005.324281221989;5009.064258853271;5013.824516141991;4818.325434439182;4967.82612608557;5059.544640982329;5070.442251352349;5074.95963327517;4349.043210493686;4356.455443069616;4358.280883654225;4363.563643635674;4398.47218333802;3772.5472943246436;3786.73492855503;3796.354619714655;3832.7125465590193;3835.884923452301;4261.722988005769;4348.347747837786;4369.453818272716;4376.934345984812;4447.73313601185;5073.492650734971;5102.438731739506;5125.103106956268;5128.871778205575;5141.048905952411;4376.321670141133;4377.0808130293;4379.605835474823;4405.757683327448;4430.911381772346;4468.754218518013;4566.520515345841;4606.930896036562;4644.465886423037;4667.719936803803;4718.268668356411;4728.196206644879;4733.384659994179;4738.289256611536;4785.258284965836;5031.798728050983;5055.772490237875;5060.342155519759;5060.595152387727;5108.846734597968;4651.930221046755;4707.223308154116;4761.2382018876815;4774.116788394158;4805.111054454937;4966.453690094159;4995.850124496271;4997.275395067768;5017.98561151085;5072.771725272445;4902.289168070539;5079.5428411443145;5095.872603184802;5096.23556466533;5148.536631703015;4899.11815873132;4934.654574179916;4950.653454258168;4986.252062190701;4997.650164488451;4930.359053323045;4945.7527123644395;4948.950510494849;4949.901001979868;4996.625253105959;4716.481187069488;4839;4875.634327425528;4882.80468781259;4927.063857866994;4918.631102667243;4947.035328110984;4949.1586430306215;4954.876128096682;4997.775100120431;4804.06320767461;4808.663393562557;4817.614590832655;4848.175810112219;4862.343583616308 05:57:07 INFO - PROCESS | 29228 | |1;ext.html;523.2961666558477;536.6619030011094;560.4199653358774;565.7227958300434;574.7155158196693;26727.73272267277;34483.13792155198;34883;34950.300993980105;35064.64935350646;37802;38530.422043669365;38648.80675596618;38680;38707;7230.385417239515;7397.334239918407;7678.3473404760525;7860.606969651523;9648.469334186617;9741.512924353789;9884.90115098847;9894.50527473627;9897.158741506944;9900.702978910609;9862.260330475207;9953.25350598708;9956;9957.651482198124;9958.701238962843;9764.511774411287;9898.109170174646;9900.108990190918;9900.950495247549;9914.553845076916;9713.417194968324;10039.74900627483;10081;10081.294309398345;10092.798144037151;38010.619893800984;38363.80818095891;38399;38436.42345364822;38472.230555388735;2933.3399985003416;2938.676745557987;3008.8044277122135;3066.6013418255484;3079.1224501017327;28687.713122868714;29131.563026554617;29235.269118272;29876.850615747;30229.848850755825;2998.745106665936;3029.424409362214;3075.4156710224984;3088.7683423743083;3152.5271209318557;240764;241667.99999999825;242283;242342;242477;41869.58130418657;42447.36328955068;42669;53451;53763.462365375846;40565.1886962265;40590.79704601458;40728.59271407307;40746;40777.59222407738;11130.443477826077;12258.26450412978;12336;12345.259284442962;12370.44333005017;9852.359596626196;10066.295359324924;10105;10140.03669651382;10154.796904061877;13994.300284985913;14032.36854341557;14127.576172714835;14128.505502307575;14231.857681423053;5596.944030559724;5637.9718101409235;5645.294338207724;5764.423557644286;5771.653700777967;866.358894418126;881.2941580653337;952.3999880075509;974.878140232471;1051.5688567687212;25893.74106258951;26845.86577067141;27247.139050399423;27368.315792105357;27680.30799229995;975.6780262513354;978.8531720242021;993.9353941993747;1002.2883752535636;1062.6015244283394;13506.89753164583;14048.789268160986;14073.155610663393;14161.645958851112;14492.637684057772;280804;283411;285554;286382;287729;46501.534984650396;46801.5319846804;46821.29768053482;46882.13973253343;46913.29630055552;1053.984190237147;1139.9658010259704;1182.3024415594668;1194.205853107691;1243.975120497585;24241.393965150306;25317.240482785546;25801.22596322113;26926.730732692424;27193;35937.46093808542;36321.27357452889;36367.818160909024;36380.636193638784;36414.4537831938;198038;202227.93316200539;202450;203193;203513;27268.72731272662;31086.533701994034;31403.371932560764;31447;31657.575409106186;35231.295374092886;35625.28749424945;35692.46461303031;36210.637893620726;36395.45406818953;29526.40947181087;31441.213969650027;31475.685243148193;31714;33906.15234619154;32333.35333293368;32526.186845329055;32538.83730581332;32750.34499310048;32767.836160819043;32677.836610816794;32922.50616240806;32935.34129317352;32937.83531082329;37075.629243708296;28896.855515723128;29217.85391073031;29542.55686164752;29620.555691665075;29835;22995.6550651737;23178.884105579364;23330;23378.415539610964;23479.88260058757 05:57:07 INFO - PROCESS | 29228 | |2;jquery.html;345.4438354249658;345.57839435888206;356.34788337342655;357.0181999501371;357.03600279246024;15456.613584660388;15978.440754573592;16156.676866462663;16897.57756056096;16920;15797.60505987348;16233.83766162338;16243.756343654824;16246;16250.43123490678;4545.431821022364;4636.5595268449615;4684.344191813149;4843.66094373394;5091.439941606439;4911.631627627942;5059.898802023958;5072.213806859942;5091.439941606421;5092.2870798088115;5049.141645920184;5074.340335756347;5076.74616269185;5080.136376815932;5081.314022606956;5109.69341839489;5254.710990895518;5288.735563221862;5294.708791016493;5319.281896943901;5046.949530504685;5095.108356037716;5101.642884998015;5111.6677415968215;5123.308353372285;13736.862631373659;18169.00070496122;19530.51173720654;19535.316263930836;19609.509762255915;1977.2980591889816;2007.3074789197703;2151.774063723318;2262.988685056581;2494.052260141135;8778.429402088845;9244.768880777967;10084.49577521121;10831;12902.612921612274;1780.2256018631806;1796.5418818201274;1813.8911665300125;1841.898695571743;1881.604862978776;43158;51405.742971284904;52694.209586856225;53889.46110538884;59050.704746476425;9644.132028117503;9976.551055202533;10169;10187.898121018843;10257.384556926609;13013.089083764045;13121.409536570878;13154.21074735519;13165.210087394787;13172.275524846225;6691.1636045494315;6826.692798824065;6858.691358888762;6898.379145876896;6916.273791251947;6375.234971803413;6413.583117097373;6491.610503369813;6506.34936506355;6508.251551071688;4293.656507479394;4367.213901497761;4393.165298593257;4427.070315233773;4458.888527786831;1639.9508014759576;1727.3263427263378;1777.4312220089448;1778.2264714849082;1803.5491127218195;831.7130589946458;848.6987119572586;874.2306770042322;935.3499317973943;990.8860481044773;15929.840701593068;15974.281157347947;16096.597585060234;16252;16636;871.6905498548051;874.0822136756381;906;914.7438717159206;920.9861852072224;9308.767280817898;9333.906660933304;9378.343515953955;9388.2020028297;9515;416120;423611;427166;438748;442009;68179;68227.65886170637;68235;69914.3008569918;70912;907.7821322882461;929.2705226397246;933.1601558597181;947.4504787223394;947.9810403791886;14263.500777472738;14620.342084606431;14635.85364146345;14688.853111468748;14807.555773326818;33494.49758253579;33544.32911341711;33766.49350259797;34009.149771255914;34032.48951265783;42357.57642423536;46518;46581;46706.76646616745;47118;7480.887786683095;7562.621868906643;7575.24247575238;7605.449331732411;7705.730299439717;8513.233808957224;10557.73605659834;10788.62239821634;10912.945435272773;11308;9581.898081720412;9613.69271374879;9664.178544823768;9749.902500975184;9886.209103271578;9540.236781057638;9690.273229507957;9787.217022638315;9927.553260103168;9982.850257246002;9523.19052880513;9550.761230969281;9727.513624318897;9773.41359518431;9884.209263258777;7072.68172932209;7186.640667966685;7245.529040612554;7306.452016098708;7356.190819009797;8359.582020899052;9322.627094916128;9363.859542106738;9540.33217674756;9723.02769723022 05:57:07 INFO - PROCESS | 29228 | |3;mootools.html;1282.0961222338253;1366.5080570994442;1392.5822253324;1493.6041948883549;1697.5501492104595;6936.445084393249;7090.290970902907;7117.786466406016;7124.430045596353;7142.642867856599;7016.754413595512;7154.284571542856;7157.28427157284;7165.176004759454;7165.3192946670115;1921.4523860699703;1976.4268362174953;1976.6145601607693;2187.5515519318583;2222.7221597300336;2181.7381914170323;2242.372135801978;2243.7756224377595;2244.236959433792;2245.663150527426;2172.2940044485526;2192.0355043780764;2203.732853609173;2205.228170140446;2243.663450482424;2203.603351396748;2214.1807531213394;2215.8670479771185;2216.34617787753;2218.401031721426;2114.6299397605358;2135.47680818199;2156.2022051840763;2163.286115581854;2165.4586353411646;7272.600006999613;7297.708091676326;7311.926880731178;7312.23221561739;7348.044754181922;4339.739615623042;4458.554144585548;4467.82128714851;4468.575485328888;4469.240229161051;2938.6620538638117;2948.4840152973143;3046.8019578727312;3072.4316001539564;3079.8152110873193;947.5215016416735;961.3799099580801;968.4479846487505;969.1229437359201;977.6871401151634;9839.45882976436;9863.50682465881;9883.258755593359;9909.058639429242;9937.90062099377;4071.511418629724;4085.816138273785;4119.7940102994735;4158.334666453414;4162.7502349859105;8459.788505287417;8468.66125354979;8479.745607631781;8483.194096560817;8495.277901378453;4457.487388950248;4458.576435238647;4459;4463.464384273908;4470.485894122217;3565.0552603560077;3936.3505021671676;4056.7971601419813;4076;4083.693722970789;3529.629388914127;3534.787912725193;3567.8037707926314;3590.192206753512;3590.3716849551224;1139.3448766959032;1153.210051114989;1160.4835848047537;1161.2451906260828;1167.0313639679046;981.2444417798398;993.7515621094726;999.9550020249106;1043.2906217675416;1184.8459700238914;6764.864702705919;6844.178698556205;6850.6574671266235;6854.725810967605;6859.622720750406;452.27184233384224;1084.4469320646526;1107.6067995861515;1115.6374178392055;1130.6212418839616;5229;5281.815136470205;5319.707416092152;5321.893562128813;5326.467353264643;8355;8448.873266901;8535.701250456204;8654.22112009922;8667.263282621048;8582.527960962207;8600.8709869352;8654.740357789276;8670.393072484865;8672.696455624024;6782.864342713118;6833.384995350343;6984.196817366068;6985.301469853076;7029.015937768717;6641.601503909781;6653.301403352772;6675.198976122896;6705.09481220029;6706.865862682622;7824.295813376823;7890.171531989058;7919.406044546567;7952.84094318122;7958.64186111638;8014.559199244098;8148.918510815053;8232.547209903512;8284.875726863982;8292.502449853027;5502.697351645698;5734.139879018181;5887.911681324698;6014.759409623741;6143.815685529263;6865.107536020286;6866.038754574463;6907.861842763016;6912.93087069143;6913.827154321182;5951.434613711691;6018.428249316308;6157.384261573986;6158.168647232566;6160;5864.794732184353;5922.3485416605;5948.583599148018;6000.21997140369;6012.789552365646;6154.138420621027;6228.906566401417;6231.9688401557705;6240.375962403905;6241;5883.470487656132;5885.911711324419;5894.174815525744;5925;5933.851653708692;5949.3753155918;5955.434233747787;6029.698515074317;6048.243969503812;6110.358412366638 05:57:07 INFO - PROCESS | 29228 | |4;prototype.html;310.5667593706779;312.1322722830531;314.4701178514203;315.9921001974952;316.26626227152985;5305.867353316169;5389.51494365507;5457.918131228034;5487.945120548793;5512.6968016759065;5332.653377530458;5363.892722145564;5376.731163441832;5391.382585224436;5485.835424937249;3950.9012274693077;4033.3143365627766;4117.855875044374;4169.541350451455;4176.0603864130635;4098.344264917614;4111.09555897702;4118.444010058649;4123.525794533622;4128.091819799639;4063.4920634920636;4103.117829666621;4105.733127346728;4106.1992911382295;4120.237756015147;3899.337112690849;4019.6985226107868;4094.5086589609436;4094.959050409517;4096.5698601646845;3523.8061906595126;3532.6643968822923;3556.1287484566187;3556.6621170988715;3572.160542272564;5173.974130129325;5201.141811601081;5203.5837133029645;5209.958008398336;5212.270282160501;4761.523847615245;4764.976175119137;4768.260919557474;4777.689450185727;4780.37855078841;5704.971475142598;5706.4864162225185;5712.685802280873;5715.085586306171;5718.5711071669375;3961.227560625679;3968.206358728266;3968.3650615901315;3968.940465893014;3975.1453437510786;5857.26784151981;5944.940550594482;6062.514998800086;6068.575199735976;6069.484093852028;4016.758994460342;4032.9395059074136;4052.473178486837;4057.411675307064;4058.492688413948;4110.506739191256;4118.052847845012;4118.464599602033;4119.423280740699;4121.423000779893;4742.52574742523;4751.786169622375;4751.976240118846;4753.881152971203;4770.809167633325;5747.942520574741;5760.855978600569;5772.220750198753;5780.046292361797;5788.82633520995;1418.5744276716944;1438.762604170321;1440.827100747917;1443.5741456270425;1447.2474313356995;891.4963045879058;938.0994245524237;951.0632027452954;955.2501286490071;977.9266555008403;4927.965127323302;5000.524950129732;5004.649674522749;5006.599472042228;5010.524000220046;5881.882362352729;5891.116332550066;6019.097135429721;6064.9090263646085;6093.969530152321;5067.4932506749765;5068.41713202979;5068.949310506921;5070.416902056237;5073.822416215415;3175.7935734177204;3213.4697774867354;3216.067340471237;3219.211293233173;3221.6617255187866;5586.469285417878;5592.888142237132;5600.971995139998;5604.579656525777;5611.186377975171;5935.347111817697;6093.847653808691;6123.908141377883;6187.876242475215;6189.319174890758;5468.0977638689965;5510.118381059011;5517.44825517445;5517.834464966058;5519.641223320552;5956.195913551615;6043.8186854394435;6092.75628974836;6099.390060994043;6107.114468402146;5895.498882594856;5910.995130827856;5917.053271476715;5920.970395147997;5922.082077278029;5384.7576859040655;5609.074502707008;5609.49514543693;5617.466340697627;5619.325680918316;4094.1402305514985;4120.546739858553;4140.544540100526;4152.854650087233;4155.709100363067;5851;5863.589548731718;5867.383924687846;5868.2077919480325;5872.324682661549;5687.800926967537;5693.686847223276;5704.857378565403;5708.229389032594;5712.11462223356;5674.886502270014;5675.631083979528;5688.943110569007;5692.886142277049;5693.886122277614;5469.097598896296;5624.240727501899;5643.040683083967;5648.63283886546;5714.457126573136;5816.389279125631;5865.384134665969;5875.441833025856;5887.676177810262;5916.290045194604;5663.065594176915;5684.914726279027;5689.118186681071;5693.601447898773;5705.400932902152 05:57:07 INFO - PROCESS | 29228 | |5;yui.html;748.4947660329278;756.2701992577165;756.9243075692432;758.6889375356105;779.6881247501001;11598.942005289973;11799.646010619685;11816.822747658782;12801.807972880415;13155.14491558048;13406.329683515834;13495.932520337385;13497.2576508292;13501.054926155173;13514.797278040838;641.5637366590717;793.0483419896119;803.028335713787;807.0557447786105;807.7738233294687;776.4836383804763;796.6733639207926;797.6809276289501;798.321426787232;798.4011991006745;840.1304649687575;841.478283464253;842.0232530264894;844.8817165596821;845.750503601439;669.0633113640893;678.2674711311771;841.4404421059987;841.5581819544757;842.2461896602537;501.28316507394413;501.7115158783714;598.0431309904162;606.851321426249;608.2943785209136;11876.88123118775;11882.40587970598;11885.28688278706;11919;11936.343501107436;11514.481848316762;11714.765704685859;11871.940640296829;11879.287242765462;12450.501979920793;9339.439633622005;9416.95291523538;9456.669016584456;9636;9749;3047.101105173957;3096.2568983444035;3163.4780261256865;3196.392685389792;3222.7421806255443;40972.79513602413;42072.57927420717;42297.788511057246;43308.56691433077;43835.342469862975;9733.270004749673;9869.555869985725;9949.502524873727;10036.397816131055;10191.592336306612;16443.917780411022;16554.917225414036;16560;16571.6685666286;16614.169291535374;6727.192736871607;6775.1869775626255;6808.8297792554595;6825.453963682893;6949.687264073129;3818.885433437001;3864.7294689371474;3865.8453661853773;3872.8257228424786;3897.0647044709067;2885.5960165576835;2943.7203465670727;2945.396193780313;2949.3953739483354;2951.439226546949;528.6722232215974;536.1154095741979;545.2067242162644;549.2968999680415;549.9835004949858;538.251829956361;548.1777333999001;578.3782433883592;578.4244676546863;578.8668606220593;8104.432689711663;8142.51144931306;8189.22202390772;8226.465279756796;8429.957850210709;495.91321518734077;559.3148393218275;582.126809785322;593.3147214966721;598.3926314790491;3731.1231860512758;3872.9419058714143;3917.5494818095713;3918.804059796999;3990.74060186087;48377;48777;48893.755531222116;48973.51026489761;49048.26427603589;41052.79473602613;41359.379609305885;42510;42881;43139.56860431418;42143.789281053396;42704.35943460851;43014.784926075794;43073.78463107727;43164;8810.647574096964;8898.73303800887;8910.509921954355;8919.821603568022;8945.865812012695;31482.52776208313;31547.684523154476;31943;32335.35329293448;32417.67582324241;39404.40893386659;40068.398974015996;48979.265311021074;49281.75359123181;49772;11564.517095981215;11801.40992950332;11981.101417393556;12118.151729378858;12230.205036672587;12525.561605344134;12885.162464439782;12969.740605188032;12992.675183120498;13419.865801342252;11339.716507087389;11502.079833613458;12187.451564679788;12320.137590368588;12468.68828279264;11287.153463490107;11775.76448471043;12018.879811201776;12285.078619103782;12321.876781232073;11824.881751182722;12243.571474998333;12250.754984900073;12257.203281786655;12286.447109880255;9726.95136524341;10009.599616015568;10060.496975151067;10119.139873110867;10338.896611033793;9511.429314241168;9526.237900968044;9690;9698.806023879342;10151.847722284025 05:57:07 INFO - PROCESS | 29228 | __end_tp_report 05:57:07 INFO - PROCESS | 29228 | __start_cc_report 05:57:07 INFO - PROCESS | 29228 | _x_x_mozilla_cycle_collect,823 05:57:07 INFO - PROCESS | 29228 | __end_cc_report 05:57:07 INFO - PROCESS | 29228 | __startTimestamp1458565027402__endTimestamp 05:57:07 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | ------- Summary: start ------- 05:57:07 INFO - PROCESS | 29228 | Number of tests: 6 05:57:07 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | [#0] dojo.html Cycles:165 Average:4677.53 Median:4774.12 stddev:481.59 (10.1%) stddev-sans-first:455.10 05:57:07 INFO - PROCESS | 29228 | Values: 2615.9 2679.2 2682.2 2698.7 2717.7 4609.6 4694.8 4702.6 4703.2 4721.0 4715.8 4717.4 4746.6 4746.8 4753.0 4269.3 4331.8 4352.9 4397.8 4415.6 4241.5 4295.0 4369.3 4381.5 4390.4 4291.5 4338.8 4361.1 4399.1 4400.3 4319.4 4326.9 4328.7 4361.2 4362.6 4222.5 4266.6 4309.8 4316.9 4338.3 4629.6 4683.7 4684.5 4687.4 4733.1 5058.3 5058.6 5061.6 5062.7 5064.7 4946.8 4973.3 5047.3 5089.5 5099.9 4744.0 4756.7 4759.3 4762.8 4790.2 5192.0 5205.9 5208.6 5262.6 5271.9 4834.8 4953.2 5012.5 5037.2 5044.9 5023.6 5031.7 5038.3 5040.6 5094.5 4998.3 5004.0 5005.3 5009.1 5013.8 4818.3 4967.8 5059.5 5070.4 5075.0 4349.0 4356.5 4358.3 4363.6 4398.5 3772.5 3786.7 3796.4 3832.7 3835.9 4261.7 4348.3 4369.5 4376.9 4447.7 5073.5 5102.4 5125.1 5128.9 5141.0 4376.3 4377.1 4379.6 4405.8 4430.9 4468.8 4566.5 4606.9 4644.5 4667.7 4718.3 4728.2 4733.4 4738.3 4785.3 5031.8 5055.8 5060.3 5060.6 5108.8 4651.9 4707.2 4761.2 4774.1 4805.1 4966.5 4995.9 4997.3 5018.0 5072.8 4902.3 5079.5 5095.9 5096.2 5148.5 4899.1 4934.7 4950.7 4986.3 4997.7 4930.4 4945.8 4949.0 4949.9 4996.6 4716.5 4839.0 4875.6 4882.8 4927.1 4918.6 4947.0 4949.2 4954.9 4997.8 4804.1 4808.7 4817.6 4848.2 4862.3 05:57:07 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | [#1] ext.html Cycles:180 Average:39497.29 Median:32023.68 stddev:63844.99 (199.4%) stddev-sans-first:63957.03 05:57:07 INFO - PROCESS | 29228 | Values: 523.3 536.7 560.4 565.7 574.7 26727.7 34483.1 34883.0 34950.3 35064.6 37802.0 38530.4 38648.8 38680.0 38707.0 7230.4 7397.3 7678.3 7860.6 9648.5 9741.5 9884.9 9894.5 9897.2 9900.7 9862.3 9953.3 9956.0 9957.7 9958.7 9764.5 9898.1 9900.1 9901.0 9914.6 9713.4 10039.7 10081.0 10081.3 10092.8 38010.6 38363.8 38399.0 38436.4 38472.2 2933.3 2938.7 3008.8 3066.6 3079.1 28687.7 29131.6 29235.3 29876.9 30229.8 2998.7 3029.4 3075.4 3088.8 3152.5 240764.0 241668.0 242283.0 242342.0 242477.0 41869.6 42447.4 42669.0 53451.0 53763.5 40565.2 40590.8 40728.6 40746.0 40777.6 11130.4 12258.3 12336.0 12345.3 12370.4 9852.4 10066.3 10105.0 10140.0 10154.8 13994.3 14032.4 14127.6 14128.5 14231.9 5596.9 5638.0 5645.3 5764.4 5771.7 866.4 881.3 952.4 974.9 1051.6 25893.7 26845.9 27247.1 27368.3 27680.3 975.7 978.9 993.9 1002.3 1062.6 13506.9 14048.8 14073.2 14161.6 14492.6 280804.0 283411.0 285554.0 286382.0 287729.0 46501.5 46801.5 46821.3 46882.1 46913.3 1054.0 1140.0 1182.3 1194.2 1244.0 24241.4 25317.2 25801.2 26926.7 27193.0 35937.5 36321.3 36367.8 36380.6 36414.5 198038.0 202227.9 202450.0 203193.0 203513.0 27268.7 31086.5 31403.4 31447.0 31657.6 35231.3 35625.3 35692.5 36210.6 36395.5 29526.4 31441.2 31475.7 31714.0 33906.2 32333.4 32526.2 32538.8 32750.3 32767.8 32677.8 32922.5 32935.3 32937.8 37075.6 28896.9 29217.9 29542.6 29620.6 29835.0 22995.7 23178.9 23330.0 23378.4 23479.9 05:57:07 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | [#2] jquery.html Cycles:180 Average:24165.58 Median:5075.54 stddev:70307.74 (1385.2%) stddev-sans-first:70482.22 05:57:07 INFO - PROCESS | 29228 | Values: 345.4 345.6 356.3 357.0 357.0 15456.6 15978.4 16156.7 16897.6 16920.0 15797.6 16233.8 16243.8 16246.0 16250.4 4545.4 4636.6 4684.3 4843.7 5091.4 4911.6 5059.9 5072.2 5091.4 5092.3 5049.1 5074.3 5076.7 5080.1 5081.3 5109.7 5254.7 5288.7 5294.7 5319.3 5046.9 5095.1 5101.6 5111.7 5123.3 13736.9 18169.0 19530.5 19535.3 19609.5 1977.3 2007.3 2151.8 2263.0 2494.1 8778.4 9244.8 10084.5 10831.0 12902.6 1780.2 1796.5 1813.9 1841.9 1881.6 43158.0 51405.7 52694.2 53889.5 59050.7 9644.1 9976.6 10169.0 10187.9 10257.4 13013.1 13121.4 13154.2 13165.2 13172.3 6691.2 6826.7 6858.7 6898.4 6916.3 6375.2 6413.6 6491.6 6506.3 6508.3 4293.7 4367.2 4393.2 4427.1 4458.9 1640.0 1727.3 1777.4 1778.2 1803.5 831.7 848.7 874.2 935.3 990.9 15929.8 15974.3 16096.6 16252.0 16636.0 871.7 874.1 906.0 914.7 921.0 9308.8 9333.9 9378.3 9388.2 9515.0 416120.0 423611.0 427166.0 438748.0 442009.0 68179.0 68227.7 68235.0 69914.3 70912.0 907.8 929.3 933.2 947.5 948.0 14263.5 14620.3 14635.9 14688.9 14807.6 33494.5 33544.3 33766.5 34009.1 34032.5 42357.6 46518.0 46581.0 46706.8 47118.0 7480.9 7562.6 7575.2 7605.4 7705.7 8513.2 10557.7 10788.6 10912.9 11308.0 9581.9 9613.7 9664.2 9749.9 9886.2 9540.2 9690.3 9787.2 9927.6 9982.9 9523.2 9550.8 9727.5 9773.4 9884.2 7072.7 7186.6 7245.5 7306.5 7356.2 8359.6 9322.6 9363.9 9540.3 9723.0 05:57:07 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | [#3] mootools.html Cycles:180 Average:5050.12 Median:5977.83 stddev:2581.21 (43.2%) stddev-sans-first:2572.91 05:57:07 INFO - PROCESS | 29228 | Values: 1282.1 1366.5 1392.6 1493.6 1697.6 6936.4 7090.3 7117.8 7124.4 7142.6 7016.8 7154.3 7157.3 7165.2 7165.3 1921.5 1976.4 1976.6 2187.6 2222.7 2181.7 2242.4 2243.8 2244.2 2245.7 2172.3 2192.0 2203.7 2205.2 2243.7 2203.6 2214.2 2215.9 2216.3 2218.4 2114.6 2135.5 2156.2 2163.3 2165.5 7272.6 7297.7 7311.9 7312.2 7348.0 4339.7 4458.6 4467.8 4468.6 4469.2 2938.7 2948.5 3046.8 3072.4 3079.8 947.5 961.4 968.4 969.1 977.7 9839.5 9863.5 9883.3 9909.1 9937.9 4071.5 4085.8 4119.8 4158.3 4162.8 8459.8 8468.7 8479.7 8483.2 8495.3 4457.5 4458.6 4459.0 4463.5 4470.5 3565.1 3936.4 4056.8 4076.0 4083.7 3529.6 3534.8 3567.8 3590.2 3590.4 1139.3 1153.2 1160.5 1161.2 1167.0 981.2 993.8 1000.0 1043.3 1184.8 6764.9 6844.2 6850.7 6854.7 6859.6 452.3 1084.4 1107.6 1115.6 1130.6 5229.0 5281.8 5319.7 5321.9 5326.5 8355.0 8448.9 8535.7 8654.2 8667.3 8582.5 8600.9 8654.7 8670.4 8672.7 6782.9 6833.4 6984.2 6985.3 7029.0 6641.6 6653.3 6675.2 6705.1 6706.9 7824.3 7890.2 7919.4 7952.8 7958.6 8014.6 8148.9 8232.5 8284.9 8292.5 5502.7 5734.1 5887.9 6014.8 6143.8 6865.1 6866.0 6907.9 6912.9 6913.8 5951.4 6018.4 6157.4 6158.2 6160.0 5864.8 5922.3 5948.6 6000.2 6012.8 6154.1 6228.9 6232.0 6240.4 6241.0 5883.5 5885.9 5894.2 5925.0 5933.9 5949.4 5955.4 6029.7 6048.2 6110.4 05:57:07 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | [#4] prototype.html Cycles:180 Average:4731.17 Median:5390.45 stddev:1415.84 (26.3%) stddev-sans-first:1380.39 05:57:07 INFO - PROCESS | 29228 | Values: 310.6 312.1 314.5 316.0 316.3 5305.9 5389.5 5457.9 5487.9 5512.7 5332.7 5363.9 5376.7 5391.4 5485.8 3950.9 4033.3 4117.9 4169.5 4176.1 4098.3 4111.1 4118.4 4123.5 4128.1 4063.5 4103.1 4105.7 4106.2 4120.2 3899.3 4019.7 4094.5 4095.0 4096.6 3523.8 3532.7 3556.1 3556.7 3572.2 5174.0 5201.1 5203.6 5210.0 5212.3 4761.5 4765.0 4768.3 4777.7 4780.4 5705.0 5706.5 5712.7 5715.1 5718.6 3961.2 3968.2 3968.4 3968.9 3975.1 5857.3 5944.9 6062.5 6068.6 6069.5 4016.8 4032.9 4052.5 4057.4 4058.5 4110.5 4118.1 4118.5 4119.4 4121.4 4742.5 4751.8 4752.0 4753.9 4770.8 5747.9 5760.9 5772.2 5780.0 5788.8 1418.6 1438.8 1440.8 1443.6 1447.2 891.5 938.1 951.1 955.3 977.9 4928.0 5000.5 5004.6 5006.6 5010.5 5881.9 5891.1 6019.1 6064.9 6094.0 5067.5 5068.4 5068.9 5070.4 5073.8 3175.8 3213.5 3216.1 3219.2 3221.7 5586.5 5592.9 5601.0 5604.6 5611.2 5935.3 6093.8 6123.9 6187.9 6189.3 5468.1 5510.1 5517.4 5517.8 5519.6 5956.2 6043.8 6092.8 6099.4 6107.1 5895.5 5911.0 5917.1 5921.0 5922.1 5384.8 5609.1 5609.5 5617.5 5619.3 4094.1 4120.5 4140.5 4152.9 4155.7 5851.0 5863.6 5867.4 5868.2 5872.3 5687.8 5693.7 5704.9 5708.2 5712.1 5674.9 5675.6 5688.9 5692.9 5693.9 5469.1 5624.2 5643.0 5648.6 5714.5 5816.4 5865.4 5875.4 5887.7 5916.3 5663.1 5684.9 5689.1 5693.6 5705.4 05:57:07 INFO - PROCESS | 29228 | 05:57:07 INFO - PROCESS | 29228 | [#5] yui.html Cycles:180 Average:12888.14 Median:42607.18 stddev:14184.16 (33.3%) stddev-sans-first:14194.65 05:57:07 INFO - PROCESS | 29228 | Values: 748.5 756.3 756.9 758.7 779.7 11598.9 11799.6 11816.8 12801.8 13155.1 13406.3 13495.9 13497.3 13501.1 13514.8 641.6 793.0 803.0 807.1 807.8 776.5 796.7 797.7 798.3 798.4 840.1 841.5 842.0 844.9 845.8 669.1 678.3 841.4 841.6 842.2 501.3 501.7 598.0 606.9 608.3 11876.9 11882.4 11885.3 11919.0 11936.3 11514.5 11714.8 11871.9 11879.3 12450.5 9339.4 9417.0 9456.7 9636.0 9749.0 3047.1 3096.3 3163.5 3196.4 3222.7 40972.8 42072.6 42297.8 43308.6 43835.3 9733.3 9869.6 9949.5 10036.4 10191.6 16443.9 16554.9 16560.0 16571.7 16614.2 6727.2 6775.2 6808.8 6825.5 6949.7 3818.9 3864.7 3865.8 3872.8 3897.1 2885.6 2943.7 2945.4 2949.4 2951.4 528.7 536.1 545.2 549.3 550.0 538.3 548.2 578.4 578.4 578.9 8104.4 8142.5 8189.2 8226.5 8430.0 495.9 559.3 582.1 593.3 598.4 3731.1 3872.9 3917.5 3918.8 3990.7 48377.0 48777.0 48893.8 48973.5 49048.3 41052.8 41359.4 42510.0 42881.0 43139.6 42143.8 42704.4 43014.8 43073.8 43164.0 8810.6 8898.7 8910.5 8919.8 8945.9 31482.5 31547.7 31943.0 32335.4 32417.7 39404.4 40068.4 48979.3 49281.8 49772.0 11564.5 11801.4 11981.1 12118.2 12230.2 12525.6 12885.2 12969.7 12992.7 13419.9 11339.7 11502.1 12187.5 12320.1 12468.7 11287.2 11775.8 12018.9 12285.1 12321.9 11824.9 12243.6 12250.8 12257.2 12286.4 9727.0 10009.6 10060.5 10119.1 10338.9 9511.4 9526.2 9690.0 9698.8 10151.8 05:57:07 INFO - PROCESS | 29228 | -------- Summary: end -------- 05:57:07 INFO - PROCESS | 29228 | 05:57:08 INFO - TEST-INFO | 29228: exit 0 05:57:08 INFO - TEST-OK | dromaeo_css | took 1116483ms 05:57:08 INFO - TEST-START | kraken 05:57:08 INFO - operating with platform_type : linux_ 05:57:08 INFO - Initialising browser for kraken test... 05:57:08 INFO - TEST-INFO | started process 29408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5MxQS4/profile http://localhost:59450/getInfo.html) 05:57:12 INFO - PROCESS | 29408 | __metrics Screen width/height:1600/1200 05:57:12 INFO - PROCESS | 29408 | colorDepth:24 05:57:12 INFO - PROCESS | 29408 | Browser inner width/height: 1024/697 05:57:12 INFO - PROCESS | 29408 | __metrics 05:57:13 ERROR - PROCESS | 29408 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:57:14 INFO - TEST-INFO | 29408: exit 0 05:57:14 INFO - Browser initialized. 05:57:14 INFO - Running cycle 1/1 for kraken test... 05:57:14 INFO - TEST-INFO | started process 29491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5MxQS4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:25 INFO - PROCESS | 29491 | RSS: Main: 158064640 05:57:25 INFO - PROCESS | 29491 | 05:57:28 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59450/tests/kraken/driver.html?testName=audio-beat-detection) 05:57:29 INFO - PROCESS | 29491 | RSS: Main: 199905280 05:57:29 INFO - PROCESS | 29491 | 05:57:31 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59450/tests/kraken/driver.html?testName=audio-dft) 05:57:32 INFO - PROCESS | 29491 | RSS: Main: 189681664 05:57:32 INFO - PROCESS | 29491 | 05:57:35 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59450/tests/kraken/driver.html?testName=audio-fft) 05:57:36 INFO - PROCESS | 29491 | RSS: Main: 175726592 05:57:36 INFO - PROCESS | 29491 | 05:57:38 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59450/tests/kraken/driver.html?testName=audio-oscillator) 05:57:38 INFO - PROCESS | 29491 | RSS: Main: 178180096 05:57:38 INFO - PROCESS | 29491 | 05:57:40 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:41 INFO - PROCESS | 29491 | RSS: Main: 176336896 05:57:41 INFO - PROCESS | 29491 | 05:57:44 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59450/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:45 INFO - PROCESS | 29491 | RSS: Main: 176971776 05:57:45 INFO - PROCESS | 29491 | 05:57:48 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59450/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:49 INFO - PROCESS | 29491 | RSS: Main: 179765248 05:57:49 INFO - PROCESS | 29491 | 05:57:52 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59450/tests/kraken/driver.html?testName=json-parse-financial) 05:57:52 INFO - PROCESS | 29491 | RSS: Main: 177541120 05:57:52 INFO - PROCESS | 29491 | 05:57:54 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:54 INFO - PROCESS | 29491 | RSS: Main: 189337600 05:57:54 INFO - PROCESS | 29491 | 05:57:56 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59450/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:57 INFO - PROCESS | 29491 | RSS: Main: 186871808 05:57:57 INFO - PROCESS | 29491 | 05:57:59 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:58:00 INFO - PROCESS | 29491 | RSS: Main: 197181440 05:58:00 INFO - PROCESS | 29491 | 05:58:02 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:03 INFO - PROCESS | 29491 | RSS: Main: 201293824 05:58:03 INFO - PROCESS | 29491 | 05:58:05 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:06 INFO - PROCESS | 29491 | RSS: Main: 200531968 05:58:06 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | Cycle 1(1): loaded http://localhost:59450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59450/tests/kraken/driver.html?testName=ai-astar) 05:58:08 INFO - PROCESS | 29491 | RSS: Main: 259969024 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | __start_tp_report 05:58:08 INFO - PROCESS | 29491 | _x_x_mozilla_page_load 05:58:08 INFO - PROCESS | 29491 | _x_x_mozilla_page_load_details 05:58:08 INFO - PROCESS | 29491 | |i|pagename|runs| 05:58:08 INFO - PROCESS | 29491 | |0;ai-astar;110;114;106;112;112;113;102;111;112;113 05:58:08 INFO - PROCESS | 29491 | |1;audio-beat-detection;152;131;152;164;132;149;152;132;174;138 05:58:08 INFO - PROCESS | 29491 | |2;audio-dft;161;162;159;162;162;161;161;162;164;162 05:58:08 INFO - PROCESS | 29491 | |3;audio-fft;74;74;74;148;73;74;73;77;149;73 05:58:08 INFO - PROCESS | 29491 | |4;audio-oscillator;95;95;137;93;94;93;143;93;93;137 05:58:08 INFO - PROCESS | 29491 | |5;imaging-gaussian-blur;118;118;117;117;117;116;117;117;117;117 05:58:08 INFO - PROCESS | 29491 | |6;imaging-darkroom;145;146;146;145;146;146;146;146;146;145 05:58:08 INFO - PROCESS | 29491 | |7;imaging-desaturate;96;97;95;95;96;95;96;95;97;96 05:58:08 INFO - PROCESS | 29491 | |8;json-parse-financial;69;69;68;69;68;69;69;76;65;67 05:58:08 INFO - PROCESS | 29491 | |9;json-stringify-tinderbox;63;65;64;65;65;66;65;64;65;65 05:58:08 INFO - PROCESS | 29491 | |10;stanford-crypto-aes;81;81;82;82;82;82;83;83;80;82 05:58:08 INFO - PROCESS | 29491 | |11;stanford-crypto-ccm;122;115;113;124;123;117;123;125;118;121 05:58:08 INFO - PROCESS | 29491 | |12;stanford-crypto-pbkdf2;140;138;137;138;136;127;138;136;138;140 05:58:08 INFO - PROCESS | 29491 | |13;stanford-crypto-sha256-iterative;67;69;67;66;66;65;66;65;67;66 05:58:08 INFO - PROCESS | 29491 | __end_tp_report 05:58:08 INFO - PROCESS | 29491 | __start_cc_report 05:58:08 INFO - PROCESS | 29491 | _x_x_mozilla_cycle_collect,1132 05:58:08 INFO - PROCESS | 29491 | __end_cc_report 05:58:08 INFO - PROCESS | 29491 | __startTimestamp1458565088311__endTimestamp 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | ------- Summary: start ------- 05:58:08 INFO - PROCESS | 29491 | Number of tests: 14 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.72 (3.3%) stddev-sans-first:3.94 05:58:08 INFO - PROCESS | 29491 | Values: 110.0 114.0 106.0 112.0 112.0 113.0 102.0 111.0 112.0 113.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.00 stddev:14.45 (9.5%) stddev-sans-first:15.24 05:58:08 INFO - PROCESS | 29491 | Values: 152.0 131.0 152.0 164.0 132.0 149.0 152.0 132.0 174.0 138.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 05:58:08 INFO - PROCESS | 29491 | Values: 161.0 162.0 159.0 162.0 162.0 161.0 161.0 162.0 164.0 162.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#3] audio-fft Cycles:10 Average:88.90 Median:74.00 stddev:31.43 (42.5%) stddev-sans-first:32.88 05:58:08 INFO - PROCESS | 29491 | Values: 74.0 74.0 74.0 148.0 73.0 74.0 73.0 77.0 149.0 73.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:93.00 stddev:21.95 (23.6%) stddev-sans-first:22.83 05:58:08 INFO - PROCESS | 29491 | Values: 95.0 95.0 137.0 93.0 94.0 93.0 143.0 93.0 93.0 137.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 05:58:08 INFO - PROCESS | 29491 | Values: 118.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 05:58:08 INFO - PROCESS | 29491 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 05:58:08 INFO - PROCESS | 29491 | Values: 96.0 97.0 95.0 95.0 96.0 95.0 96.0 95.0 97.0 96.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:69.00 stddev:2.81 (4.1%) stddev-sans-first:2.98 05:58:08 INFO - PROCESS | 29491 | Values: 69.0 69.0 68.0 69.0 68.0 69.0 69.0 76.0 65.0 67.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 05:58:08 INFO - PROCESS | 29491 | Values: 63.0 65.0 64.0 65.0 65.0 66.0 65.0 64.0 65.0 65.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 05:58:08 INFO - PROCESS | 29491 | Values: 81.0 81.0 82.0 82.0 82.0 82.0 83.0 83.0 80.0 82.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:122.50 stddev:4.09 (3.3%) stddev-sans-first:4.28 05:58:08 INFO - PROCESS | 29491 | Values: 122.0 115.0 113.0 124.0 123.0 117.0 123.0 125.0 118.0 121.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.80 Median:138.00 stddev:3.71 (2.7%) stddev-sans-first:3.75 05:58:08 INFO - PROCESS | 29491 | Values: 140.0 138.0 137.0 138.0 136.0 127.0 138.0 136.0 138.0 140.0 05:58:08 INFO - PROCESS | 29491 | 05:58:08 INFO - PROCESS | 29491 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 05:58:08 INFO - PROCESS | 29491 | Values: 67.0 69.0 67.0 66.0 66.0 65.0 66.0 65.0 67.0 66.0 05:58:08 INFO - PROCESS | 29491 | -------- Summary: end -------- 05:58:08 INFO - PROCESS | 29491 | 05:58:09 INFO - TEST-INFO | 29491: exit 0 05:58:09 INFO - TEST-OK | kraken | took 61206ms 05:58:09 INFO - SUITE-END | took 1177s 05:58:09 INFO - Completed test suite (00:19:37) 05:58:09 INFO - javascript benchmark 05:58:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2615.869206539673, 2679.1560658392605, 2682.155121136842, 2698.7301269873, 2717.687465941416, 4609.6081833044145, 4694.765261736912, 4702.6002789762915, 4703.153432382174, 4720.952790472094, 4715.811367545302, 4717.363155973942, 4746.62027037837, 4746.762661866902, 4753.0, 4269.295566231568, 4331.826726930919, 4352.891177720567, 4397.758123303217, 4415.646748260147, 4241.533431322552, 4294.978525107385, 4369.3227549729845, 4381.53993830648, 4390.385346051556, 4291.549387314334, 4338.783060846945, 4361.084172323815, 4399.142167277382, 4400.3399490076745, 4319.352097185416, 4326.870193894189, 4328.696991210617, 4361.214981303364, 4362.563743625644, 4222.535521092677, 4266.616004559604, 4309.82760689572, 4316.892077698083, 4338.349247612852, 4629.560191781776, 4683.695559788603, 4684.508126646721, 4687.437507499088, 4733.0533893221145, 5058.342415486, 5058.620603454756, 5061.620378471629, 5062.670926389773, 5064.721440320781, 4946.826861059845, 4973.278874563204, 5047.268146118829, 5089.541941225308, 5099.923501147486, 4743.976280118577, 4756.667033307635, 4759.333693282943, 4762.833300834454, 4790.185668436374, 5192.039472697563, 5205.9219111713355, 5208.609354298443, 5262.631615786935, 5271.920921186109, 4834.830780922651, 4953.2074868020945, 5012.498750125032, 5037.168867136955, 5044.873878153002, 5023.623228257895, 5031.723255220924, 5038.345015148007, 5040.571551418097, 5094.541491265803, 4998.300237966688, 5003.974980125076, 5005.324281221989, 5009.064258853271, 5013.824516141991, 4818.325434439182, 4967.82612608557, 5059.544640982329, 5070.442251352349, 5074.95963327517, 4349.043210493686, 4356.455443069616, 4358.280883654225, 4363.563643635674, 4398.47218333802, 3772.5472943246436, 3786.73492855503, 3796.354619714655, 3832.7125465590193, 3835.884923452301, 4261.722988005769, 4348.347747837786, 4369.453818272716, 4376.934345984812, 4447.73313601185, 5073.492650734971, 5102.438731739506, 5125.103106956268, 5128.871778205575, 5141.048905952411, 4376.321670141133, 4377.0808130293, 4379.605835474823, 4405.757683327448, 4430.911381772346, 4468.754218518013, 4566.520515345841, 4606.930896036562, 4644.465886423037, 4667.719936803803, 4718.268668356411, 4728.196206644879, 4733.384659994179, 4738.289256611536, 4785.258284965836, 5031.798728050983, 5055.772490237875, 5060.342155519759, 5060.595152387727, 5108.846734597968, 4651.930221046755, 4707.223308154116, 4761.2382018876815, 4774.116788394158, 4805.111054454937, 4966.453690094159, 4995.850124496271, 4997.275395067768, 5017.98561151085, 5072.771725272445, 4902.289168070539, 5079.5428411443145, 5095.872603184802, 5096.23556466533, 5148.536631703015, 4899.11815873132, 4934.654574179916, 4950.653454258168, 4986.252062190701, 4997.650164488451, 4930.359053323045, 4945.7527123644395, 4948.950510494849, 4949.901001979868, 4996.625253105959, 4716.481187069488, 4839.0, 4875.634327425528, 4882.80468781259, 4927.063857866994, 4918.631102667243, 4947.035328110984, 4949.1586430306215, 4954.876128096682, 4997.775100120431, 4804.06320767461, 4808.663393562557, 4817.614590832655, 4848.175810112219, 4862.343583616308], "unit": "score", "name": "dojo.html", "value": 4647.525669578323}, {"lowerIsBetter": false, "replicates": [523.2961666558477, 536.6619030011094, 560.4199653358774, 565.7227958300434, 574.7155158196693, 26727.73272267277, 34483.13792155198, 34883.0, 34950.300993980105, 35064.64935350646, 37802.0, 38530.422043669365, 38648.80675596618, 38680.0, 38707.0, 7230.385417239515, 7397.334239918407, 7678.3473404760525, 7860.606969651523, 9648.469334186617, 9741.512924353789, 9884.90115098847, 9894.50527473627, 9897.158741506944, 9900.702978910609, 9862.260330475207, 9953.25350598708, 9956.0, 9957.651482198124, 9958.701238962843, 9764.511774411287, 9898.109170174646, 9900.108990190918, 9900.950495247549, 9914.553845076916, 9713.417194968324, 10039.74900627483, 10081.0, 10081.294309398345, 10092.798144037151, 38010.619893800984, 38363.80818095891, 38399.0, 38436.42345364822, 38472.230555388735, 2933.3399985003416, 2938.676745557987, 3008.8044277122135, 3066.6013418255484, 3079.1224501017327, 28687.713122868714, 29131.563026554617, 29235.269118272, 29876.850615747, 30229.848850755825, 2998.745106665936, 3029.424409362214, 3075.4156710224984, 3088.7683423743083, 3152.5271209318557, 240764.0, 241667.99999999825, 242283.0, 242342.0, 242477.0, 41869.58130418657, 42447.36328955068, 42669.0, 53451.0, 53763.462365375846, 40565.1886962265, 40590.79704601458, 40728.59271407307, 40746.0, 40777.59222407738, 11130.443477826077, 12258.26450412978, 12336.0, 12345.259284442962, 12370.44333005017, 9852.359596626196, 10066.295359324924, 10105.0, 10140.03669651382, 10154.796904061877, 13994.300284985913, 14032.36854341557, 14127.576172714835, 14128.505502307575, 14231.857681423053, 5596.944030559724, 5637.9718101409235, 5645.294338207724, 5764.423557644286, 5771.653700777967, 866.358894418126, 881.2941580653337, 952.3999880075509, 974.878140232471, 1051.5688567687212, 25893.74106258951, 26845.86577067141, 27247.139050399423, 27368.315792105357, 27680.30799229995, 975.6780262513354, 978.8531720242021, 993.9353941993747, 1002.2883752535636, 1062.6015244283394, 13506.89753164583, 14048.789268160986, 14073.155610663393, 14161.645958851112, 14492.637684057772, 280804.0, 283411.0, 285554.0, 286382.0, 287729.0, 46501.534984650396, 46801.5319846804, 46821.29768053482, 46882.13973253343, 46913.29630055552, 1053.984190237147, 1139.9658010259704, 1182.3024415594668, 1194.205853107691, 1243.975120497585, 24241.393965150306, 25317.240482785546, 25801.22596322113, 26926.730732692424, 27193.0, 35937.46093808542, 36321.27357452889, 36367.818160909024, 36380.636193638784, 36414.4537831938, 198038.0, 202227.93316200539, 202450.0, 203193.0, 203513.0, 27268.72731272662, 31086.533701994034, 31403.371932560764, 31447.0, 31657.575409106186, 35231.295374092886, 35625.28749424945, 35692.46461303031, 36210.637893620726, 36395.45406818953, 29526.40947181087, 31441.213969650027, 31475.685243148193, 31714.0, 33906.15234619154, 32333.35333293368, 32526.186845329055, 32538.83730581332, 32750.34499310048, 32767.836160819043, 32677.836610816794, 32922.50616240806, 32935.34129317352, 32937.83531082329, 37075.629243708296, 28896.855515723128, 29217.85391073031, 29542.55686164752, 29620.555691665075, 29835.0, 22995.6550651737, 23178.884105579364, 23330.0, 23378.415539610964, 23479.88260058757], "unit": "score", "name": "ext.html", "value": 16519.37522726777}, {"lowerIsBetter": false, "replicates": [345.4438354249658, 345.57839435888206, 356.34788337342655, 357.0181999501371, 357.03600279246024, 15456.613584660388, 15978.440754573592, 16156.676866462663, 16897.57756056096, 16920.0, 15797.60505987348, 16233.83766162338, 16243.756343654824, 16246.0, 16250.43123490678, 4545.431821022364, 4636.5595268449615, 4684.344191813149, 4843.66094373394, 5091.439941606439, 4911.631627627942, 5059.898802023958, 5072.213806859942, 5091.439941606421, 5092.2870798088115, 5049.141645920184, 5074.340335756347, 5076.74616269185, 5080.136376815932, 5081.314022606956, 5109.69341839489, 5254.710990895518, 5288.735563221862, 5294.708791016493, 5319.281896943901, 5046.949530504685, 5095.108356037716, 5101.642884998015, 5111.6677415968215, 5123.308353372285, 13736.862631373659, 18169.00070496122, 19530.51173720654, 19535.316263930836, 19609.509762255915, 1977.2980591889816, 2007.3074789197703, 2151.774063723318, 2262.988685056581, 2494.052260141135, 8778.429402088845, 9244.768880777967, 10084.49577521121, 10831.0, 12902.612921612274, 1780.2256018631806, 1796.5418818201274, 1813.8911665300125, 1841.898695571743, 1881.604862978776, 43158.0, 51405.742971284904, 52694.209586856225, 53889.46110538884, 59050.704746476425, 9644.132028117503, 9976.551055202533, 10169.0, 10187.898121018843, 10257.384556926609, 13013.089083764045, 13121.409536570878, 13154.21074735519, 13165.210087394787, 13172.275524846225, 6691.1636045494315, 6826.692798824065, 6858.691358888762, 6898.379145876896, 6916.273791251947, 6375.234971803413, 6413.583117097373, 6491.610503369813, 6506.34936506355, 6508.251551071688, 4293.656507479394, 4367.213901497761, 4393.165298593257, 4427.070315233773, 4458.888527786831, 1639.9508014759576, 1727.3263427263378, 1777.4312220089448, 1778.2264714849082, 1803.5491127218195, 831.7130589946458, 848.6987119572586, 874.2306770042322, 935.3499317973943, 990.8860481044773, 15929.840701593068, 15974.281157347947, 16096.597585060234, 16252.0, 16636.0, 871.6905498548051, 874.0822136756381, 906.0, 914.7438717159206, 920.9861852072224, 9308.767280817898, 9333.906660933304, 9378.343515953955, 9388.2020028297, 9515.0, 416120.0, 423611.0, 427166.0, 438748.0, 442009.0, 68179.0, 68227.65886170637, 68235.0, 69914.3008569918, 70912.0, 907.7821322882461, 929.2705226397246, 933.1601558597181, 947.4504787223394, 947.9810403791886, 14263.500777472738, 14620.342084606431, 14635.85364146345, 14688.853111468748, 14807.555773326818, 33494.49758253579, 33544.32911341711, 33766.49350259797, 34009.149771255914, 34032.48951265783, 42357.57642423536, 46518.0, 46581.0, 46706.76646616745, 47118.0, 7480.887786683095, 7562.621868906643, 7575.24247575238, 7605.449331732411, 7705.730299439717, 8513.233808957224, 10557.73605659834, 10788.62239821634, 10912.945435272773, 11308.0, 9581.898081720412, 9613.69271374879, 9664.178544823768, 9749.902500975184, 9886.209103271578, 9540.236781057638, 9690.273229507957, 9787.217022638315, 9927.553260103168, 9982.850257246002, 9523.19052880513, 9550.761230969281, 9727.513624318897, 9773.41359518431, 9884.209263258777, 7072.68172932209, 7186.640667966685, 7245.529040612554, 7306.452016098708, 7356.190819009797, 8359.582020899052, 9322.627094916128, 9363.859542106738, 9540.33217674756, 9723.02769723022], "unit": "score", "name": "jquery.html", "value": 7888.821361374504}, {"lowerIsBetter": false, "replicates": [1282.0961222338253, 1366.5080570994442, 1392.5822253324, 1493.6041948883549, 1697.5501492104595, 6936.445084393249, 7090.290970902907, 7117.786466406016, 7124.430045596353, 7142.642867856599, 7016.754413595512, 7154.284571542856, 7157.28427157284, 7165.176004759454, 7165.3192946670115, 1921.4523860699703, 1976.4268362174953, 1976.6145601607693, 2187.5515519318583, 2222.7221597300336, 2181.7381914170323, 2242.372135801978, 2243.7756224377595, 2244.236959433792, 2245.663150527426, 2172.2940044485526, 2192.0355043780764, 2203.732853609173, 2205.228170140446, 2243.663450482424, 2203.603351396748, 2214.1807531213394, 2215.8670479771185, 2216.34617787753, 2218.401031721426, 2114.6299397605358, 2135.47680818199, 2156.2022051840763, 2163.286115581854, 2165.4586353411646, 7272.600006999613, 7297.708091676326, 7311.926880731178, 7312.23221561739, 7348.044754181922, 4339.739615623042, 4458.554144585548, 4467.82128714851, 4468.575485328888, 4469.240229161051, 2938.6620538638117, 2948.4840152973143, 3046.8019578727312, 3072.4316001539564, 3079.8152110873193, 947.5215016416735, 961.3799099580801, 968.4479846487505, 969.1229437359201, 977.6871401151634, 9839.45882976436, 9863.50682465881, 9883.258755593359, 9909.058639429242, 9937.90062099377, 4071.511418629724, 4085.816138273785, 4119.7940102994735, 4158.334666453414, 4162.7502349859105, 8459.788505287417, 8468.66125354979, 8479.745607631781, 8483.194096560817, 8495.277901378453, 4457.487388950248, 4458.576435238647, 4459.0, 4463.464384273908, 4470.485894122217, 3565.0552603560077, 3936.3505021671676, 4056.7971601419813, 4076.0, 4083.693722970789, 3529.629388914127, 3534.787912725193, 3567.8037707926314, 3590.192206753512, 3590.3716849551224, 1139.3448766959032, 1153.210051114989, 1160.4835848047537, 1161.2451906260828, 1167.0313639679046, 981.2444417798398, 993.7515621094726, 999.9550020249106, 1043.2906217675416, 1184.8459700238914, 6764.864702705919, 6844.178698556205, 6850.6574671266235, 6854.725810967605, 6859.622720750406, 452.27184233384224, 1084.4469320646526, 1107.6067995861515, 1115.6374178392055, 1130.6212418839616, 5229.0, 5281.815136470205, 5319.707416092152, 5321.893562128813, 5326.467353264643, 8355.0, 8448.873266901, 8535.701250456204, 8654.22112009922, 8667.263282621048, 8582.527960962207, 8600.8709869352, 8654.740357789276, 8670.393072484865, 8672.696455624024, 6782.864342713118, 6833.384995350343, 6984.196817366068, 6985.301469853076, 7029.015937768717, 6641.601503909781, 6653.301403352772, 6675.198976122896, 6705.09481220029, 6706.865862682622, 7824.295813376823, 7890.171531989058, 7919.406044546567, 7952.84094318122, 7958.64186111638, 8014.559199244098, 8148.918510815053, 8232.547209903512, 8284.875726863982, 8292.502449853027, 5502.697351645698, 5734.139879018181, 5887.911681324698, 6014.759409623741, 6143.815685529263, 6865.107536020286, 6866.038754574463, 6907.861842763016, 6912.93087069143, 6913.827154321182, 5951.434613711691, 6018.428249316308, 6157.384261573986, 6158.168647232566, 6160.0, 5864.794732184353, 5922.3485416605, 5948.583599148018, 6000.21997140369, 6012.789552365646, 6154.138420621027, 6228.906566401417, 6231.9688401557705, 6240.375962403905, 6241.0, 5883.470487656132, 5885.911711324419, 5894.174815525744, 5925.0, 5933.851653708692, 5949.3753155918, 5955.434233747787, 6029.698515074317, 6048.243969503812, 6110.358412366638], "unit": "score", "name": "mootools.html", "value": 4174.088547809808}, {"lowerIsBetter": false, "replicates": [310.5667593706779, 312.1322722830531, 314.4701178514203, 315.9921001974952, 316.26626227152985, 5305.867353316169, 5389.51494365507, 5457.918131228034, 5487.945120548793, 5512.6968016759065, 5332.653377530458, 5363.892722145564, 5376.731163441832, 5391.382585224436, 5485.835424937249, 3950.9012274693077, 4033.3143365627766, 4117.855875044374, 4169.541350451455, 4176.0603864130635, 4098.344264917614, 4111.09555897702, 4118.444010058649, 4123.525794533622, 4128.091819799639, 4063.4920634920636, 4103.117829666621, 4105.733127346728, 4106.1992911382295, 4120.237756015147, 3899.337112690849, 4019.6985226107868, 4094.5086589609436, 4094.959050409517, 4096.5698601646845, 3523.8061906595126, 3532.6643968822923, 3556.1287484566187, 3556.6621170988715, 3572.160542272564, 5173.974130129325, 5201.141811601081, 5203.5837133029645, 5209.958008398336, 5212.270282160501, 4761.523847615245, 4764.976175119137, 4768.260919557474, 4777.689450185727, 4780.37855078841, 5704.971475142598, 5706.4864162225185, 5712.685802280873, 5715.085586306171, 5718.5711071669375, 3961.227560625679, 3968.206358728266, 3968.3650615901315, 3968.940465893014, 3975.1453437510786, 5857.26784151981, 5944.940550594482, 6062.514998800086, 6068.575199735976, 6069.484093852028, 4016.758994460342, 4032.9395059074136, 4052.473178486837, 4057.411675307064, 4058.492688413948, 4110.506739191256, 4118.052847845012, 4118.464599602033, 4119.423280740699, 4121.423000779893, 4742.52574742523, 4751.786169622375, 4751.976240118846, 4753.881152971203, 4770.809167633325, 5747.942520574741, 5760.855978600569, 5772.220750198753, 5780.046292361797, 5788.82633520995, 1418.5744276716944, 1438.762604170321, 1440.827100747917, 1443.5741456270425, 1447.2474313356995, 891.4963045879058, 938.0994245524237, 951.0632027452954, 955.2501286490071, 977.9266555008403, 4927.965127323302, 5000.524950129732, 5004.649674522749, 5006.599472042228, 5010.524000220046, 5881.882362352729, 5891.116332550066, 6019.097135429721, 6064.9090263646085, 6093.969530152321, 5067.4932506749765, 5068.41713202979, 5068.949310506921, 5070.416902056237, 5073.822416215415, 3175.7935734177204, 3213.4697774867354, 3216.067340471237, 3219.211293233173, 3221.6617255187866, 5586.469285417878, 5592.888142237132, 5600.971995139998, 5604.579656525777, 5611.186377975171, 5935.347111817697, 6093.847653808691, 6123.908141377883, 6187.876242475215, 6189.319174890758, 5468.0977638689965, 5510.118381059011, 5517.44825517445, 5517.834464966058, 5519.641223320552, 5956.195913551615, 6043.8186854394435, 6092.75628974836, 6099.390060994043, 6107.114468402146, 5895.498882594856, 5910.995130827856, 5917.053271476715, 5920.970395147997, 5922.082077278029, 5384.7576859040655, 5609.074502707008, 5609.49514543693, 5617.466340697627, 5619.325680918316, 4094.1402305514985, 4120.546739858553, 4140.544540100526, 4152.854650087233, 4155.709100363067, 5851.0, 5863.589548731718, 5867.383924687846, 5868.2077919480325, 5872.324682661549, 5687.800926967537, 5693.686847223276, 5704.857378565403, 5708.229389032594, 5712.11462223356, 5674.886502270014, 5675.631083979528, 5688.943110569007, 5692.886142277049, 5693.886122277614, 5469.097598896296, 5624.240727501899, 5643.040683083967, 5648.63283886546, 5714.457126573136, 5816.389279125631, 5865.384134665969, 5875.441833025856, 5887.676177810262, 5916.290045194604, 5663.065594176915, 5684.914726279027, 5689.118186681071, 5693.601447898773, 5705.400932902152], "unit": "score", "name": "prototype.html", "value": 4274.06599280613}, {"lowerIsBetter": false, "replicates": [748.4947660329278, 756.2701992577165, 756.9243075692432, 758.6889375356105, 779.6881247501001, 11598.942005289973, 11799.646010619685, 11816.822747658782, 12801.807972880415, 13155.14491558048, 13406.329683515834, 13495.932520337385, 13497.2576508292, 13501.054926155173, 13514.797278040838, 641.5637366590717, 793.0483419896119, 803.028335713787, 807.0557447786105, 807.7738233294687, 776.4836383804763, 796.6733639207926, 797.6809276289501, 798.321426787232, 798.4011991006745, 840.1304649687575, 841.478283464253, 842.0232530264894, 844.8817165596821, 845.750503601439, 669.0633113640893, 678.2674711311771, 841.4404421059987, 841.5581819544757, 842.2461896602537, 501.28316507394413, 501.7115158783714, 598.0431309904162, 606.851321426249, 608.2943785209136, 11876.88123118775, 11882.40587970598, 11885.28688278706, 11919.0, 11936.343501107436, 11514.481848316762, 11714.765704685859, 11871.940640296829, 11879.287242765462, 12450.501979920793, 9339.439633622005, 9416.95291523538, 9456.669016584456, 9636.0, 9749.0, 3047.101105173957, 3096.2568983444035, 3163.4780261256865, 3196.392685389792, 3222.7421806255443, 40972.79513602413, 42072.57927420717, 42297.788511057246, 43308.56691433077, 43835.342469862975, 9733.270004749673, 9869.555869985725, 9949.502524873727, 10036.397816131055, 10191.592336306612, 16443.917780411022, 16554.917225414036, 16560.0, 16571.6685666286, 16614.169291535374, 6727.192736871607, 6775.1869775626255, 6808.8297792554595, 6825.453963682893, 6949.687264073129, 3818.885433437001, 3864.7294689371474, 3865.8453661853773, 3872.8257228424786, 3897.0647044709067, 2885.5960165576835, 2943.7203465670727, 2945.396193780313, 2949.3953739483354, 2951.439226546949, 528.6722232215974, 536.1154095741979, 545.2067242162644, 549.2968999680415, 549.9835004949858, 538.251829956361, 548.1777333999001, 578.3782433883592, 578.4244676546863, 578.8668606220593, 8104.432689711663, 8142.51144931306, 8189.22202390772, 8226.465279756796, 8429.957850210709, 495.91321518734077, 559.3148393218275, 582.126809785322, 593.3147214966721, 598.3926314790491, 3731.1231860512758, 3872.9419058714143, 3917.5494818095713, 3918.804059796999, 3990.74060186087, 48377.0, 48777.0, 48893.755531222116, 48973.51026489761, 49048.26427603589, 41052.79473602613, 41359.379609305885, 42510.0, 42881.0, 43139.56860431418, 42143.789281053396, 42704.35943460851, 43014.784926075794, 43073.78463107727, 43164.0, 8810.647574096964, 8898.73303800887, 8910.509921954355, 8919.821603568022, 8945.865812012695, 31482.52776208313, 31547.684523154476, 31943.0, 32335.35329293448, 32417.67582324241, 39404.40893386659, 40068.398974015996, 48979.265311021074, 49281.75359123181, 49772.0, 11564.517095981215, 11801.40992950332, 11981.101417393556, 12118.151729378858, 12230.205036672587, 12525.561605344134, 12885.162464439782, 12969.740605188032, 12992.675183120498, 13419.865801342252, 11339.716507087389, 11502.079833613458, 12187.451564679788, 12320.137590368588, 12468.68828279264, 11287.153463490107, 11775.76448471043, 12018.879811201776, 12285.078619103782, 12321.876781232073, 11824.881751182722, 12243.571474998333, 12250.754984900073, 12257.203281786655, 12286.447109880255, 9726.95136524341, 10009.599616015568, 10060.496975151067, 10119.139873110867, 10338.896611033793, 9511.429314241168, 9526.237900968044, 9690.0, 9698.806023879342, 10151.847722284025], "unit": "score", "name": "yui.html", "value": 6007.804693510982}], "name": "dromaeo_css", "value": 6339.640818238441}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 106.0, 112.0, 112.0, 113.0, 102.0, 111.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [152.0, 131.0, 152.0, 164.0, 132.0, 149.0, 152.0, 132.0, 174.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 159.0, 162.0, 162.0, 161.0, 161.0, 162.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 148.0, 73.0, 74.0, 73.0, 77.0, 149.0, 73.0], "unit": "score", "name": "audio-fft", "value": 88.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 137.0, 93.0, 94.0, 93.0, 143.0, 93.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 76.0, 65.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 68.9}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 82.0, 82.0, 82.0, 83.0, 83.0, 80.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [122.0, 115.0, 113.0, 124.0, 123.0, 117.0, 123.0, 125.0, 118.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [140.0, 138.0, 137.0, 138.0, 136.0, 127.0, 138.0, 136.0, 138.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1513.2}]} 05:58:09 INFO - Return code: 0 05:58:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:58:09 ERROR - # TBPL SUCCESS # 05:58:09 INFO - Running post-action listener: _resource_record_post_action 05:58:09 INFO - Running post-run listener: _resource_record_post_run 05:58:10 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520364032; Read time: 12; Write time: 460724 05:58:10 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 231886848; Read time: 0; Write time: 291152 05:58:10 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287735808; Read time: 12; Write time: 169552 05:58:10 INFO - Running post-run listener: _upload_blobber_files 05:58:10 INFO - Blob upload gear active. 05:58:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:58:10 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 05:58:10 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'] 05:58:10 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 05:58:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:11 INFO - (blobuploader) - INFO - Done attempting. 05:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:58:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:58:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:58:12 INFO - (blobuploader) - INFO - Done attempting. 05:58:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:58:12 INFO - Return code: 0 05:58:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:58:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:58:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5535b1c65f2ce5928038ed043344d441377520cb99efadcb50005d89dc8d291b5542fc1ad73ceb1360564927f06d324b5625a8f47c22a421f0000cbfd01d7f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a287046a33f9dac79a8ae99b8d333b06c341b5cd01a9b3a49ab896d130fcd245926ac418cc4ffe2d5de4e215608a794e14f4452d83f45168be9df623d1c1cb19"} 05:58:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:58:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:58:12 INFO - Contents: 05:58:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5535b1c65f2ce5928038ed043344d441377520cb99efadcb50005d89dc8d291b5542fc1ad73ceb1360564927f06d324b5625a8f47c22a421f0000cbfd01d7f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a287046a33f9dac79a8ae99b8d333b06c341b5cd01a9b3a49ab896d130fcd245926ac418cc4ffe2d5de4e215608a794e14f4452d83f45168be9df623d1c1cb19"} 05:58:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:58:12 INFO - Copying logs to upload dir... 05:58:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:58:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.588946 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-03-21 05:58:12.413741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 05:58:12.417042) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 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/f5535b1c65f2ce5928038ed043344d441377520cb99efadcb50005d89dc8d291b5542fc1ad73ceb1360564927f06d324b5625a8f47c22a421f0000cbfd01d7f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a287046a33f9dac79a8ae99b8d333b06c341b5cd01a9b3a49ab896d130fcd245926ac418cc4ffe2d5de4e215608a794e14f4452d83f45168be9df623d1c1cb19"} build_url:https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/f9LpAThhRfeTHzvz5HJa5w/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/f5535b1c65f2ce5928038ed043344d441377520cb99efadcb50005d89dc8d291b5542fc1ad73ceb1360564927f06d324b5625a8f47c22a421f0000cbfd01d7f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a287046a33f9dac79a8ae99b8d333b06c341b5cd01a9b3a49ab896d130fcd245926ac418cc4ffe2d5de4e215608a794e14f4452d83f45168be9df623d1c1cb19"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 05:58:12.441128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 05:58:12.441418) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1458563145.612471-550030070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 05:58:12.526167) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 05:58:12.526449) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 05:58:12.526730) ========= ========= Total master_lag: 0.35 =========