builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1459825091.27 results: success (0) buildid: 20160404193615 builduid: 29bba84ee0b34f419670885c922b63c7 revision: 99272d590c8ff6925f7b9c2471be88b0ba373174 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.267268) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.267682) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.267973) ========= 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-1459821743.879755-1112691247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006316 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.315664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.315955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.388709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.388990) ========= 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-1459821743.879755-1112691247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.456227) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.456520) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.456936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.457218) ========= 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-1459821743.879755-1112691247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-04 19:58:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-04-04 19:58:11 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.567069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.567377) ========= 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-1459821743.879755-1112691247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022277 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.624650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:11.624958) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99272d590c8ff6925f7b9c2471be88b0ba373174 --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 99272d590c8ff6925f7b9c2471be88b0ba373174 --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-1459821743.879755-1112691247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-04 19:58:11,930 truncating revision to first 12 chars 2016-04-04 19:58:11,930 Setting DEBUG logging. 2016-04-04 19:58:11,930 attempt 1/10 2016-04-04 19:58:11,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99272d590c8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 19:58:12,168 unpacking tar archive at: fx-team-99272d590c8f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513713 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:12.152329) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:12.152695) ========= echo 99272d590c8ff6925f7b9c2471be88b0ba373174 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'99272d590c8ff6925f7b9c2471be88b0ba373174'] 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-1459821743.879755-1112691247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 99272d590c8ff6925f7b9c2471be88b0ba373174 program finished with exit code 0 elapsedTime=0.003587 script_repo_revision: '99272d590c8ff6925f7b9c2471be88b0ba373174' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:12.200305) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:12.200642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 19:58:12.210857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-04 19:58:12.211242) ========= /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-1459821743.879755-1112691247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:58:12 INFO - MultiFileLogger online at 20160404 19:58:12 in /builds/slave/test 19:58:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:58:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:58:12 INFO - {'append_to_log': False, 19:58:12 INFO - 'base_work_dir': '/builds/slave/test', 19:58:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:58:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:58:12 INFO - 'branch': 'Fx-Team-Non-PGO', 19:58:12 INFO - 'buildbot_json_path': 'buildprops.json', 19:58:12 INFO - 'config_files': ('talos/linux_config.py',), 19:58:12 INFO - 'default_actions': ('clobber', 19:58:12 INFO - 'read-buildbot-config', 19:58:12 INFO - 'download-and-extract', 19:58:12 INFO - 'populate-webroot', 19:58:12 INFO - 'create-virtualenv', 19:58:12 INFO - 'install', 19:58:12 INFO - 'run-tests'), 19:58:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:58:12 INFO - 'download_minidump_stackwalk': True, 19:58:12 INFO - 'download_symbols': 'ondemand', 19:58:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:58:12 INFO - 'tooltool.py': '/tools/tooltool.py', 19:58:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:58:12 INFO - '/tools/misc-python/virtualenv.py')}, 19:58:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:58:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:58:12 INFO - 'installer_path': 'installer.exe', 19:58:12 INFO - 'log_level': 'info', 19:58:12 INFO - 'log_name': 'talos', 19:58:12 INFO - 'log_to_console': True, 19:58:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:58:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:58:12 INFO - 'opt_config_files': (), 19:58:12 INFO - 'pip_index': False, 19:58:12 INFO - 'sps_profile': False, 19:58:12 INFO - 'sps_profile_interval': 0, 19:58:12 INFO - 'suite': 'dromaeojs', 19:58:12 INFO - 'system_bits': '32', 19:58:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:58:12 INFO - 'title': 'talos-linux64-ix-065', 19:58:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:58:12 INFO - 'use_talos_json': True, 19:58:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:58:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:58:12 INFO - 'work_dir': 'build'} 19:58:12 INFO - ##### 19:58:12 INFO - ##### Running clobber step. 19:58:12 INFO - ##### 19:58:12 INFO - Running pre-action listener: _resource_record_pre_action 19:58:12 INFO - Running main action method: clobber 19:58:12 INFO - rmtree: /builds/slave/test/build 19:58:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:58:13 INFO - Running post-action listener: _resource_record_post_action 19:58:13 INFO - ##### 19:58:13 INFO - ##### Running read-buildbot-config step. 19:58:13 INFO - ##### 19:58:13 INFO - Running pre-action listener: _resource_record_pre_action 19:58:13 INFO - Running main action method: read_buildbot_config 19:58:13 INFO - Using buildbot properties: 19:58:13 INFO - { 19:58:13 INFO - "project": "", 19:58:13 INFO - "product": "firefox", 19:58:13 INFO - "script_repo_revision": "production", 19:58:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:58:13 INFO - "repository": "", 19:58:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:58:13 INFO - "buildid": "20160404193615", 19:58:13 INFO - "pgo_build": "False", 19:58:13 INFO - "basedir": "/builds/slave/test", 19:58:13 INFO - "buildnumber": 2752, 19:58:13 INFO - "slavename": "talos-linux64-ix-065", 19:58:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:58:13 INFO - "platform": "ubuntu64_hw", 19:58:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:58:13 INFO - "branch": "fx-team", 19:58:13 INFO - "repo_path": "integration/fx-team", 19:58:13 INFO - "revision": "99272d590c8ff6925f7b9c2471be88b0ba373174", 19:58:13 INFO - "stage_platform": "linux64", 19:58:13 INFO - "builduid": "29bba84ee0b34f419670885c922b63c7", 19:58:13 INFO - "slavebuilddir": "test" 19:58:13 INFO - } 19:58:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:58:13 INFO - Running post-action listener: _resource_record_post_action 19:58:13 INFO - ##### 19:58:13 INFO - ##### Running download-and-extract step. 19:58:13 INFO - ##### 19:58:13 INFO - Running pre-action listener: _resource_record_pre_action 19:58:13 INFO - Running main action method: download_and_extract 19:58:13 INFO - mkdir: /builds/slave/test/build/tests 19:58:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:13 INFO - https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:58:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:58:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:58:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:19 INFO - Downloaded 1361 bytes. 19:58:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:58:19 INFO - Using the following test package requirements: 19:58:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:58:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:58:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:19 INFO - u'jsshell-linux-x86_64.zip'], 19:58:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:58:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:58:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:58:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:58:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:58:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:58:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:58:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:58:19 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')]} 19:58:19 INFO - https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:58:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:58:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:22 INFO - Downloaded 22125701 bytes. 19:58:22 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'] 19:58:22 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 19:58:23 INFO - Return code: 0 19:58:23 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 19:58:23 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')]} 19:58:23 INFO - https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:31 INFO - Downloaded 22125701 bytes. 19:58:31 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'] 19:58:31 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 19:58:32 INFO - Return code: 0 19:58:32 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')]} 19:58:32 INFO - https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:58:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:58:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:33 INFO - Downloaded 10847584 bytes. 19:58:33 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'] 19:58:33 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 19:58:34 INFO - Return code: 0 19:58:34 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')]} 19:58:34 INFO - https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:58:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:58:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:58:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L_h7Xl4ATDahjPfYWsepow/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 19:58:36 INFO - Downloaded 54087153 bytes. 19:58:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:58:36 INFO - mkdir: /builds/slave/test/properties 19:58:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:58:36 INFO - Writing to file /builds/slave/test/properties/build_url 19:58:36 INFO - Contents: 19:58:36 INFO - build_url:https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:58:37 INFO - Running post-action listener: _resource_record_post_action 19:58:37 INFO - Running post-action listener: set_extra_try_arguments 19:58:37 INFO - ##### 19:58:37 INFO - ##### Running populate-webroot step. 19:58:37 INFO - ##### 19:58:37 INFO - Running pre-action listener: _resource_record_pre_action 19:58:37 INFO - Running main action method: populate_webroot 19:58:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:58:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:58:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:58:37 INFO - '--tppagecycles', 19:58:37 INFO - '7'], 19:58:37 INFO - 'tests': ['tsvgm']}}, 19:58:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:58:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:58:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:58:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:58:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:37 INFO - 'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:58:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:37 INFO - 'tests': ['damp', 'tps']}, 19:58:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:37 INFO - 'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['damp', 'tps']}, 19:58:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:58:37 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['dromaeo_dom']}, 19:58:37 INFO - 'other': {'tests': ['a11yr', 19:58:37 INFO - 'ts_paint', 19:58:37 INFO - 'tpaint', 19:58:37 INFO - 'sessionrestore', 19:58:37 INFO - 'sessionrestore_no_auto_restore', 19:58:37 INFO - 'tabpaint']}, 19:58:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['a11yr', 19:58:37 INFO - 'ts_paint', 19:58:37 INFO - 'tpaint', 19:58:37 INFO - 'sessionrestore', 19:58:37 INFO - 'sessionrestore_no_auto_restore', 19:58:37 INFO - 'tabpaint']}, 19:58:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['a11yr', 19:58:37 INFO - 'ts_paint', 19:58:37 INFO - 'tpaint', 19:58:37 INFO - 'sessionrestore', 19:58:37 INFO - 'sessionrestore_no_auto_restore', 19:58:37 INFO - 'tabpaint']}, 19:58:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['a11yr', 19:58:37 INFO - 'ts_paint', 19:58:37 INFO - 'tpaint', 19:58:37 INFO - 'sessionrestore', 19:58:37 INFO - 'sessionrestore_no_auto_restore', 19:58:37 INFO - 'tabpaint']}, 19:58:37 INFO - 'other_l64': {'tests': ['a11yr', 19:58:37 INFO - 'ts_paint', 19:58:37 INFO - 'tpaint', 19:58:37 INFO - 'sessionrestore', 19:58:37 INFO - 'sessionrestore_no_auto_restore', 19:58:37 INFO - 'tabpaint']}, 19:58:37 INFO - 'other_nol64': {'tests': ['a11yr', 19:58:37 INFO - 'ts_paint', 19:58:37 INFO - 'tpaint', 19:58:37 INFO - 'sessionrestore', 19:58:37 INFO - 'sessionrestore_no_auto_restore', 19:58:37 INFO - 'tabpaint']}, 19:58:37 INFO - 'svgr': {'tests': ['tsvgx', 19:58:37 INFO - 'tsvgr_opacity', 19:58:37 INFO - 'tart', 19:58:37 INFO - 'tscrollx', 19:58:37 INFO - 'cart']}, 19:58:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['tsvgx', 19:58:37 INFO - 'tsvgr_opacity', 19:58:37 INFO - 'tart', 19:58:37 INFO - 'tscrollx', 19:58:37 INFO - 'cart']}, 19:58:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:37 INFO - 'tests': ['tp5o']}, 19:58:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:37 INFO - 'talos_options': ['--e10s'], 19:58:37 INFO - 'tests': ['tp5o']}, 19:58:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:37 INFO - 'talos_options': ['--xperf_path', 19:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:37 INFO - 'tests': ['tp5n']}, 19:58:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:58:37 INFO - 'talos_options': ['--e10s', 19:58:37 INFO - '--xperf_path', 19:58:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:58:37 INFO - 'tests': ['tp5n']}}, 19:58:37 INFO - 'talos.zip': {'path': '', 19:58:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:58:37 INFO - Running post-action listener: _resource_record_post_action 19:58:37 INFO - ##### 19:58:37 INFO - ##### Running create-virtualenv step. 19:58:37 INFO - ##### 19:58:37 INFO - Running pre-action listener: _resource_record_pre_action 19:58:37 INFO - Running main action method: create_virtualenv 19:58:37 INFO - Creating virtualenv /builds/slave/test/build/venv 19:58:37 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 19:58:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:58:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:58:37 INFO - Using real prefix '/usr' 19:58:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:58:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:58:39 INFO - Installing pip.................done. 19:58:39 INFO - Return code: 0 19:58:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:58:39 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')]} 19:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:39 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')]} 19:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:39 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 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58:39 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 19:58:39 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 19:58:39 INFO - Using env: {'DISPLAY': ':0', 19:58:39 INFO - 'HOME': '/home/cltbld', 19:58:39 INFO - 'LANG': 'en_US.UTF-8', 19:58:39 INFO - 'LANGUAGE': 'en_US:en', 19:58:39 INFO - 'LOGNAME': 'cltbld', 19:58:39 INFO - 'MAIL': '/var/mail/cltbld', 19:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:39 INFO - 'MOZ_NO_REMOTE': '1', 19:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:39 INFO - 'NO_EM_RESTART': '1', 19:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:39 INFO - 'PWD': '/builds/slave/test', 19:58:39 INFO - 'SHELL': '/bin/bash', 19:58:39 INFO - 'SHLVL': '1', 19:58:39 INFO - 'TERM': 'linux', 19:58:39 INFO - 'TMOUT': '86400', 19:58:39 INFO - 'USER': 'cltbld', 19:58:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:39 INFO - '_': '/tools/buildbot/bin/python'} 19:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:39 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 19:58:39 INFO - Cleaning up... 19:58:39 INFO - Return code: 0 19:58:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:58:39 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')]} 19:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:39 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')]} 19:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:39 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 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58:39 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 19:58:39 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 19:58:39 INFO - Using env: {'DISPLAY': ':0', 19:58:39 INFO - 'HOME': '/home/cltbld', 19:58:39 INFO - 'LANG': 'en_US.UTF-8', 19:58:39 INFO - 'LANGUAGE': 'en_US:en', 19:58:39 INFO - 'LOGNAME': 'cltbld', 19:58:39 INFO - 'MAIL': '/var/mail/cltbld', 19:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:39 INFO - 'MOZ_NO_REMOTE': '1', 19:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:39 INFO - 'NO_EM_RESTART': '1', 19:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:39 INFO - 'PWD': '/builds/slave/test', 19:58:39 INFO - 'SHELL': '/bin/bash', 19:58:39 INFO - 'SHLVL': '1', 19:58:39 INFO - 'TERM': 'linux', 19:58:39 INFO - 'TMOUT': '86400', 19:58:39 INFO - 'USER': 'cltbld', 19:58:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:39 INFO - '_': '/tools/buildbot/bin/python'} 19:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:40 INFO - Downloading/unpacking psutil>=0.7.1 19:58:40 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 19:58:40 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 19:58:40 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 19:58:40 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 19:58:40 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 19:58:40 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 19:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:42 INFO - Installing collected packages: psutil 19:58:42 INFO - Running setup.py install for psutil 19:58:42 INFO - building 'psutil._psutil_linux' extension 19:58:42 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 19:58:42 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 19:58:42 INFO - building 'psutil._psutil_posix' extension 19:58:42 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 19:58:42 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 19:58:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:58:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:58:42 INFO - Successfully installed psutil 19:58:42 INFO - Cleaning up... 19:58:42 INFO - Return code: 0 19:58:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:58:42 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')]} 19:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:42 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')]} 19:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:42 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 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58:42 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 19:58:42 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 19:58:42 INFO - Using env: {'DISPLAY': ':0', 19:58:42 INFO - 'HOME': '/home/cltbld', 19:58:42 INFO - 'LANG': 'en_US.UTF-8', 19:58:42 INFO - 'LANGUAGE': 'en_US:en', 19:58:42 INFO - 'LOGNAME': 'cltbld', 19:58:42 INFO - 'MAIL': '/var/mail/cltbld', 19:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:42 INFO - 'MOZ_NO_REMOTE': '1', 19:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:42 INFO - 'NO_EM_RESTART': '1', 19:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:42 INFO - 'PWD': '/builds/slave/test', 19:58:42 INFO - 'SHELL': '/bin/bash', 19:58:42 INFO - 'SHLVL': '1', 19:58:42 INFO - 'TERM': 'linux', 19:58:42 INFO - 'TMOUT': '86400', 19:58:42 INFO - 'USER': 'cltbld', 19:58:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:42 INFO - '_': '/tools/buildbot/bin/python'} 19:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:58:42 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 19:58:42 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 19:58:42 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 19:58:42 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 19:58:42 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 19:58:42 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 19:58:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:58:44 INFO - Installing collected packages: mozsystemmonitor 19:58:44 INFO - Running setup.py install for mozsystemmonitor 19:58:44 INFO - Successfully installed mozsystemmonitor 19:58:44 INFO - Cleaning up... 19:58:44 INFO - Return code: 0 19:58:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:58:44 INFO - Using env: {'DISPLAY': ':0', 19:58:44 INFO - 'HOME': '/home/cltbld', 19:58:44 INFO - 'LANG': 'en_US.UTF-8', 19:58:44 INFO - 'LANGUAGE': 'en_US:en', 19:58:44 INFO - 'LOGNAME': 'cltbld', 19:58:44 INFO - 'MAIL': '/var/mail/cltbld', 19:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:44 INFO - 'MOZ_NO_REMOTE': '1', 19:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:44 INFO - 'NO_EM_RESTART': '1', 19:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:44 INFO - 'PWD': '/builds/slave/test', 19:58:44 INFO - 'SHELL': '/bin/bash', 19:58:44 INFO - 'SHLVL': '1', 19:58:44 INFO - 'TERM': 'linux', 19:58:44 INFO - 'TMOUT': '86400', 19:58:44 INFO - 'USER': 'cltbld', 19:58:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:44 INFO - '_': '/tools/buildbot/bin/python'} 19:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:46 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 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 19:58:47 INFO - Downloading docopt-0.6.1.tar.gz 19:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:47 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:47 INFO - Running setup.py install for blobuploader 19:58:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:58:47 INFO - Running setup.py install for requests 19:58:48 INFO - Running setup.py install for docopt 19:58:48 INFO - Successfully installed blobuploader requests docopt 19:58:48 INFO - Cleaning up... 19:58:48 INFO - Return code: 0 19:58:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:48 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 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58:48 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 19:58:48 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 19:58:48 INFO - Using env: {'DISPLAY': ':0', 19:58:48 INFO - 'HOME': '/home/cltbld', 19:58:48 INFO - 'LANG': 'en_US.UTF-8', 19:58:48 INFO - 'LANGUAGE': 'en_US:en', 19:58:48 INFO - 'LOGNAME': 'cltbld', 19:58:48 INFO - 'MAIL': '/var/mail/cltbld', 19:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:48 INFO - 'MOZ_NO_REMOTE': '1', 19:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:48 INFO - 'NO_EM_RESTART': '1', 19:58:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:48 INFO - 'PWD': '/builds/slave/test', 19:58:48 INFO - 'SHELL': '/bin/bash', 19:58:48 INFO - 'SHLVL': '1', 19:58:48 INFO - 'TERM': 'linux', 19:58:48 INFO - 'TMOUT': '86400', 19:58:48 INFO - 'USER': 'cltbld', 19:58:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:48 INFO - '_': '/tools/buildbot/bin/python'} 19:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:48 INFO - Running setup.py (path:/tmp/pip-Q0r491-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:48 INFO - Running setup.py (path:/tmp/pip-YXX5fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:48 INFO - Running setup.py (path:/tmp/pip-HZpk2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:48 INFO - Running setup.py (path:/tmp/pip-lTvo45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:48 INFO - Running setup.py (path:/tmp/pip-bQH6V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:48 INFO - Running setup.py (path:/tmp/pip-UXGcWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:48 INFO - Running setup.py (path:/tmp/pip-Q4am4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:49 INFO - Running setup.py (path:/tmp/pip-LkY6FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:49 INFO - Running setup.py (path:/tmp/pip-q4NN3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:49 INFO - Running setup.py (path:/tmp/pip-xo9gPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:49 INFO - Running setup.py (path:/tmp/pip-Xj_BEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:49 INFO - Running setup.py (path:/tmp/pip-O90hys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:49 INFO - Running setup.py (path:/tmp/pip-EN501U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:49 INFO - Running setup.py (path:/tmp/pip-wMxWhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:49 INFO - Running setup.py (path:/tmp/pip-EQWqWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:49 INFO - Running setup.py (path:/tmp/pip-yzaG15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:49 INFO - Running setup.py (path:/tmp/pip-cWwWdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:49 INFO - Running setup.py install for manifestparser 19:58:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:58:49 INFO - Running setup.py install for mozcrash 19:58:49 INFO - Running setup.py install for mozdebug 19:58:50 INFO - Running setup.py install for mozdevice 19:58:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Running setup.py install for mozfile 19:58:50 INFO - Running setup.py install for mozhttpd 19:58:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Running setup.py install for mozinfo 19:58:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Running setup.py install for mozInstall 19:58:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Running setup.py install for mozleak 19:58:50 INFO - Running setup.py install for mozlog 19:58:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Running setup.py install for moznetwork 19:58:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:58:50 INFO - Running setup.py install for mozprocess 19:58:51 INFO - Running setup.py install for mozprofile 19:58:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:58:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:58:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:58:51 INFO - Running setup.py install for mozrunner 19:58:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:58:51 INFO - Running setup.py install for mozscreenshot 19:58:51 INFO - Running setup.py install for moztest 19:58:51 INFO - Running setup.py install for mozversion 19:58:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:58:51 INFO - Cleaning up... 19:58:51 INFO - Return code: 0 19:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:51 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 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58:51 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 19:58:51 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 19:58:51 INFO - Using env: {'DISPLAY': ':0', 19:58:51 INFO - 'HOME': '/home/cltbld', 19:58:51 INFO - 'LANG': 'en_US.UTF-8', 19:58:51 INFO - 'LANGUAGE': 'en_US:en', 19:58:51 INFO - 'LOGNAME': 'cltbld', 19:58:51 INFO - 'MAIL': '/var/mail/cltbld', 19:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:51 INFO - 'MOZ_NO_REMOTE': '1', 19:58:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:51 INFO - 'NO_EM_RESTART': '1', 19:58:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:51 INFO - 'PWD': '/builds/slave/test', 19:58:51 INFO - 'SHELL': '/bin/bash', 19:58:51 INFO - 'SHLVL': '1', 19:58:51 INFO - 'TERM': 'linux', 19:58:51 INFO - 'TMOUT': '86400', 19:58:51 INFO - 'USER': 'cltbld', 19:58:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:51 INFO - '_': '/tools/buildbot/bin/python'} 19:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:51 INFO - Running setup.py (path:/tmp/pip-HZgKUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:51 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)) 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:51 INFO - Running setup.py (path:/tmp/pip-59YtNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:51 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)) 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:51 INFO - Running setup.py (path:/tmp/pip-nrd8cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:51 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)) 19:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:52 INFO - Running setup.py (path:/tmp/pip-84cYxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:52 INFO - Running setup.py (path:/tmp/pip-PKNwbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:52 INFO - Running setup.py (path:/tmp/pip-SdkDt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:52 INFO - Running setup.py (path:/tmp/pip-fNoQ_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:52 INFO - Running setup.py (path:/tmp/pip-7KvTKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:52 INFO - Running setup.py (path:/tmp/pip-FuUAtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:52 INFO - Running setup.py (path:/tmp/pip-SgLkxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:52 INFO - Running setup.py (path:/tmp/pip-I1my4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:52 INFO - Running setup.py (path:/tmp/pip-vMl5cC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:52 INFO - Running setup.py (path:/tmp/pip-hPT_O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:52 INFO - Running setup.py (path:/tmp/pip-LsDdCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:52 INFO - Running setup.py (path:/tmp/pip-xBEW6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:52 INFO - Running setup.py (path:/tmp/pip-StDqmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:52 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)) 19:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:52 INFO - Running setup.py (path:/tmp/pip-235EkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:53 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)) 19:58:53 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)) 19:58:53 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)) 19:58:53 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)) 19:58:53 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)) 19:58:53 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)) 19:58:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:54 INFO - Downloading blessings-1.6.tar.gz 19:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:54 INFO - Installing collected packages: blessings 19:58:54 INFO - Running setup.py install for blessings 19:58:55 INFO - Successfully installed blessings 19:58:55 INFO - Cleaning up... 19:58:55 INFO - Return code: 0 19:58:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:58:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:55 INFO - Reading from file tmpfile_stdout 19:58:55 INFO - Current package versions: 19:58:55 INFO - argparse == 1.2.1 19:58:55 INFO - blessings == 1.6 19:58:55 INFO - blobuploader == 1.2.4 19:58:55 INFO - docopt == 0.6.1 19:58:55 INFO - manifestparser == 1.1 19:58:55 INFO - mozInstall == 1.12 19:58:55 INFO - mozcrash == 0.17 19:58:55 INFO - mozdebug == 0.1 19:58:55 INFO - mozdevice == 0.48 19:58:55 INFO - mozfile == 1.2 19:58:55 INFO - mozhttpd == 0.7 19:58:55 INFO - mozinfo == 0.9 19:58:55 INFO - mozleak == 0.1 19:58:55 INFO - mozlog == 3.1 19:58:55 INFO - moznetwork == 0.27 19:58:55 INFO - mozprocess == 0.22 19:58:55 INFO - mozprofile == 0.28 19:58:55 INFO - mozrunner == 6.11 19:58:55 INFO - mozscreenshot == 0.1 19:58:55 INFO - mozsystemmonitor == 0.0 19:58:55 INFO - moztest == 0.7 19:58:55 INFO - mozversion == 1.4 19:58:55 INFO - psutil == 3.1.1 19:58:55 INFO - requests == 1.2.3 19:58:55 INFO - wsgiref == 0.1.2 19:58:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:55 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 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58:55 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 19:58:55 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 19:58:55 INFO - Using env: {'DISPLAY': ':0', 19:58:55 INFO - 'HOME': '/home/cltbld', 19:58:55 INFO - 'LANG': 'en_US.UTF-8', 19:58:55 INFO - 'LANGUAGE': 'en_US:en', 19:58:55 INFO - 'LOGNAME': 'cltbld', 19:58:55 INFO - 'MAIL': '/var/mail/cltbld', 19:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:55 INFO - 'MOZ_NO_REMOTE': '1', 19:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:55 INFO - 'NO_EM_RESTART': '1', 19:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:55 INFO - 'PWD': '/builds/slave/test', 19:58:55 INFO - 'SHELL': '/bin/bash', 19:58:55 INFO - 'SHLVL': '1', 19:58:55 INFO - 'TERM': 'linux', 19:58:55 INFO - 'TMOUT': '86400', 19:58:55 INFO - 'USER': 'cltbld', 19:58:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:55 INFO - '_': '/tools/buildbot/bin/python'} 19:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 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)) 19:58:55 INFO - Cleaning up... 19:58:55 INFO - Return code: 0 19:58:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58: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', 'jsonschema'] in /builds/slave/test/build 19:58: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 jsonschema 19:58:55 INFO - Using env: {'DISPLAY': ':0', 19:58:55 INFO - 'HOME': '/home/cltbld', 19:58:55 INFO - 'LANG': 'en_US.UTF-8', 19:58:55 INFO - 'LANGUAGE': 'en_US:en', 19:58:55 INFO - 'LOGNAME': 'cltbld', 19:58:55 INFO - 'MAIL': '/var/mail/cltbld', 19:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:55 INFO - 'MOZ_NO_REMOTE': '1', 19:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:55 INFO - 'NO_EM_RESTART': '1', 19:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:55 INFO - 'PWD': '/builds/slave/test', 19:58:55 INFO - 'SHELL': '/bin/bash', 19:58:55 INFO - 'SHLVL': '1', 19:58:55 INFO - 'TERM': 'linux', 19:58:55 INFO - 'TMOUT': '86400', 19:58:55 INFO - 'USER': 'cltbld', 19:58:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:55 INFO - '_': '/tools/buildbot/bin/python'} 19:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:55 INFO - Downloading/unpacking jsonschema 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:57 INFO - Downloading/unpacking functools32 (from jsonschema) 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:57 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:57 INFO - warning: no files found matching '*.txt' 19:58:57 INFO - no previously-included directories found matching 'build' 19:58:57 INFO - no previously-included directories found matching 'dist' 19:58:57 INFO - no previously-included directories found matching '.git*' 19:58:57 INFO - Installing collected packages: jsonschema, functools32 19:58:57 INFO - Running setup.py install for functools32 19:58:58 INFO - warning: no files found matching '*.txt' 19:58:58 INFO - no previously-included directories found matching 'build' 19:58:58 INFO - no previously-included directories found matching 'dist' 19:58:58 INFO - no previously-included directories found matching '.git*' 19:58:58 INFO - Successfully installed jsonschema functools32 19:58:58 INFO - Cleaning up... 19:58:58 INFO - Return code: 0 19:58:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4bd0a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, '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-1459821743.879755-1112691247', '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 19:58: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', 'flake8'] in /builds/slave/test/build 19:58: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 flake8 19:58:58 INFO - Using env: {'DISPLAY': ':0', 19:58:58 INFO - 'HOME': '/home/cltbld', 19:58:58 INFO - 'LANG': 'en_US.UTF-8', 19:58:58 INFO - 'LANGUAGE': 'en_US:en', 19:58:58 INFO - 'LOGNAME': 'cltbld', 19:58:58 INFO - 'MAIL': '/var/mail/cltbld', 19:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:58 INFO - 'MOZ_NO_REMOTE': '1', 19:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:58 INFO - 'NO_EM_RESTART': '1', 19:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:58 INFO - 'PWD': '/builds/slave/test', 19:58:58 INFO - 'SHELL': '/bin/bash', 19:58:58 INFO - 'SHLVL': '1', 19:58:58 INFO - 'TERM': 'linux', 19:58:58 INFO - 'TMOUT': '86400', 19:58:58 INFO - 'USER': 'cltbld', 19:58:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:58 INFO - '_': '/tools/buildbot/bin/python'} 19:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:58 INFO - Downloading/unpacking flake8 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:59:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:59:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:59:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59: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 19:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:00 INFO - no previously-included directories found matching 'docs/_build' 19:59:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:59:00 INFO - Running setup.py install for pep8 19:59:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:59:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:59:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:59:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:59:01 INFO - no previously-included directories found matching 'docs/_build' 19:59:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:59:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:59:01 INFO - Cleaning up... 19:59:01 INFO - Return code: 0 19:59:01 INFO - Running post-action listener: _resource_record_post_action 19:59:01 INFO - Running post-action listener: _start_resource_monitoring 19:59:01 INFO - Starting resource monitoring. 19:59:01 INFO - ##### 19:59:01 INFO - ##### Running install step. 19:59:01 INFO - ##### 19:59:01 INFO - Running pre-action listener: _resource_record_pre_action 19:59:01 INFO - Running main action method: install 19:59:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:59:01 INFO - Reading from file tmpfile_stdout 19:59:01 INFO - Detecting whether we're running mozinstall >=1.0... 19:59:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:59:01 INFO - Reading from file tmpfile_stdout 19:59:01 INFO - Output received: 19:59:01 INFO - Usage: mozinstall [options] installer 19:59:01 INFO - Options: 19:59:01 INFO - -h, --help show this help message and exit 19:59:01 INFO - -d DEST, --destination=DEST 19:59:01 INFO - Directory to install application into. [default: 19:59:01 INFO - "/builds/slave/test"] 19:59:01 INFO - --app=APP Application being installed. [default: firefox] 19:59:01 INFO - mkdir: /builds/slave/test/build/application 19:59:01 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'] 19:59:01 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 19:59:17 INFO - Reading from file tmpfile_stdout 19:59:17 INFO - Output received: 19:59:17 INFO - /builds/slave/test/build/application/firefox/firefox 19:59:17 INFO - Running post-action listener: _resource_record_post_action 19:59:17 INFO - ##### 19:59:17 INFO - ##### Running run-tests step. 19:59:17 INFO - ##### 19:59:17 INFO - Running pre-action listener: _resource_record_pre_action 19:59:17 INFO - Running main action method: run_tests 19:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:59:17 INFO - Python 2.7.3 19:59:17 INFO - Return code: 0 19:59:17 INFO - grabbing minidump binary from tooltool 19:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:17 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 0x2085410>, '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 0x2086310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20867a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:59:17 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 19:59:17 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 19:59:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:59:17 INFO - Return code: 0 19:59:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:59:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:59:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:59:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:59:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:59:18 INFO - Return code: 0 19:59:18 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/L_h7Xl4ATDahjPfYWsepow/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 19:59:18 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/L_h7Xl4ATDahjPfYWsepow/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 19:59:18 INFO - Using env: {'DISPLAY': ':0', 19:59:18 INFO - 'HOME': '/home/cltbld', 19:59:18 INFO - 'LANG': 'en_US.UTF-8', 19:59:18 INFO - 'LANGUAGE': 'en_US:en', 19:59:18 INFO - 'LOGNAME': 'cltbld', 19:59:18 INFO - 'MAIL': '/var/mail/cltbld', 19:59:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:59:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:18 INFO - 'MOZ_NO_REMOTE': '1', 19:59:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:18 INFO - 'NO_EM_RESTART': '1', 19:59:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:18 INFO - 'PWD': '/builds/slave/test', 19:59:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:59:18 INFO - 'SHELL': '/bin/bash', 19:59:18 INFO - 'SHLVL': '1', 19:59:18 INFO - 'TERM': 'linux', 19:59:18 INFO - 'TMOUT': '86400', 19:59:18 INFO - 'USER': 'cltbld', 19:59:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1459821743.879755-1112691247', 19:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:18 INFO - '_': '/tools/buildbot/bin/python'} 19:59:18 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/L_h7Xl4ATDahjPfYWsepow/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 19:59:18 INFO - mozversion application_buildid: 20160404193615 19:59:18 INFO - mozversion application_changeset: 99272d590c8ff6925f7b9c2471be88b0ba373174 19:59:18 INFO - mozversion application_display_name: Nightly 19:59:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:59:18 INFO - mozversion application_name: Firefox 19:59:18 INFO - mozversion application_remotingname: firefox 19:59:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:59:18 INFO - mozversion application_vendor: Mozilla 19:59:18 INFO - mozversion application_version: 48.0a1 19:59:18 INFO - mozversion platform_buildid: 20160404193615 19:59:18 INFO - mozversion platform_changeset: 99272d590c8ff6925f7b9c2471be88b0ba373174 19:59:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:59:18 INFO - mozversion platform_version: 48.0a1 19:59:18 INFO - using testdate: 1459825158 19:59:18 INFO - actual date: 1459825158 19:59:18 INFO - starting webserver on 'localhost:48885' 19:59:18 INFO - SUITE-START | Running 2 tests 19:59:18 INFO - TEST-START | dromaeo_css 19:59:18 INFO - operating with platform_type : linux_ 19:59:18 INFO - Initialising browser for dromaeo_css test... 19:59:18 INFO - TEST-INFO | started process 6637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9VHTo/profile http://localhost:48885/getInfo.html) 19:59:22 INFO - PROCESS | 6637 | __metrics Screen width/height:1600/1200 19:59:22 INFO - PROCESS | 6637 | colorDepth:24 19:59:22 INFO - PROCESS | 6637 | Browser inner width/height: 1024/697 19:59:22 INFO - PROCESS | 6637 | __metrics 19:59:24 ERROR - PROCESS | 6637 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:59:25 INFO - TEST-INFO | 6637: exit 0 19:59:25 INFO - Browser initialized. 19:59:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:59:25 INFO - TEST-INFO | started process 6721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9VHTo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:37 INFO - PROCESS | 6721 | RSS: Main: 154136576 19:59:37 INFO - PROCESS | 6721 | 20:00:28 INFO - PROCESS | 6721 | 1459825228073 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] 20:02:39 INFO - PROCESS | 6721 | Cycle 1(1): loaded http://localhost:48885/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48885/tests/dromaeo/cssquery-ext.html) 20:02:40 INFO - PROCESS | 6721 | RSS: Main: 262082560 20:02:40 INFO - PROCESS | 6721 | 20:05:42 INFO - PROCESS | 6721 | Cycle 1(1): loaded http://localhost:48885/tests/dromaeo/cssquery-ext.html (next: http://localhost:48885/tests/dromaeo/cssquery-jquery.html) 20:05:43 INFO - PROCESS | 6721 | RSS: Main: 226607104 20:05:43 INFO - PROCESS | 6721 | 20:08:44 INFO - PROCESS | 6721 | Cycle 1(1): loaded http://localhost:48885/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48885/tests/dromaeo/cssquery-mootools.html) 20:08:45 INFO - PROCESS | 6721 | RSS: Main: 228139008 20:08:45 INFO - PROCESS | 6721 | 20:11:47 INFO - PROCESS | 6721 | Cycle 1(1): loaded http://localhost:48885/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48885/tests/dromaeo/cssquery-prototype.html) 20:11:48 INFO - PROCESS | 6721 | RSS: Main: 222040064 20:11:48 INFO - PROCESS | 6721 | 20:14:50 INFO - PROCESS | 6721 | Cycle 1(1): loaded http://localhost:48885/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48885/tests/dromaeo/cssquery-yui.html) 20:14:51 INFO - PROCESS | 6721 | RSS: Main: 223072256 20:14:51 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | Cycle 1(1): loaded http://localhost:48885/tests/dromaeo/cssquery-yui.html (next: http://localhost:48885/tests/dromaeo/cssquery-dojo.html) 20:17:53 INFO - PROCESS | 6721 | RSS: Main: 265146368 20:17:53 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | __start_tp_report 20:17:53 INFO - PROCESS | 6721 | _x_x_mozilla_page_load 20:17:53 INFO - PROCESS | 6721 | _x_x_mozilla_page_load_details 20:17:53 INFO - PROCESS | 6721 | |i|pagename|runs| 20:17:53 INFO - PROCESS | 6721 | |0;dojo.html;2595.493878693655;2623.0819213275354;2658.468306338733;2658.73412658734;2678.611601317809;4488.394066800981;4527.750973696446;4543.840965566206;4556.453225612927;4573.565511276432;4474.910501789962;4506.481754598222;4516.299973504104;4554.635629149669;4609.585137337639;4112.773797441147;4123.855665051724;4144.544100148981;4178.582141785812;4312.97843510782;4229.069604686979;4267.615914567688;4272.572742725718;4316.136772645467;4320.524742278362;4075.266452038632;4144.8134833932545;4158.126793373395;4213.557576454489;4215.473065866767;4177.874663760092;4216.810243539048;4234.407182994383;4255.319148936186;4278.336857787048;4180.665546756252;4198.03445207604;4208.537060923296;4219.156168766228;4238.364245363189;4344.782760861945;4414.690971631987;4442.311441726538;4483.170613436525;4490.865274041784;4831;4846.5153484651255;4853.199222128344;4856.490068542787;4893.828715994959;4858.587020103296;4863.805447782084;4864.294677271776;4865.78103985318;4933.925991110136;4450.621697155746;4483.798229079699;4547.8635640930825;4564.315352697122;4588.541145885418;4969.552740253323;4978.452370239271;5000.74996250186;5001.474845141281;5061.367329083864;4795.424549054136;4814.133455977958;4814.5907597853875;4816.109019831342;4865.318855360252;4780.95219047812;4863.513648635108;4907.5828554572545;4952.331435256267;4955.82654607087;4846.491118432585;4858.7570621468785;4870.537298956593;4879.243717223836;4924.162892308316;4761.833335833229;4846.709197448165;4855.053264613437;4860.659753817269;4904.607631389552;3877.2245550889934;3903.921921561553;3933.252681990413;3942.172143849766;3946.2502124596235;3446.3451944130534;3451.188970591959;3465.4108801503803;3504.737144714157;3505.9298814024087;4126.381042843597;4203.957960420418;4206.11671548972;4220.767857767853;4266.253405653998;4793.13723529768;4835.95164048362;4839.830605928775;4851.611871050378;4884.096442158212;4207.495100587949;4208.494980602347;4227.365895115758;4244.745315281093;4275.273203555403;4337.956620433818;4414.050979039458;4472.932906006413;4485.125400546862;4490.191765482179;4605.861824145281;4606.332081848181;4659.860204193879;4662.813487460464;4673.976630116827;4835.975820120877;4842.612590992782;4849.733264670477;4857;4895.681780684244;4469.039156581351;4603.907921841477;4619.376384188092;4627.6066534344955;4667.719936803803;4723.504032076583;4761.595264402426;4783.043391321819;4818.180909245507;4823.03539292136;4856.004519073652;4875.268709693574;4876.146674331907;4880.682755620874;4932.901341973069;4598.816047358202;4660.557247061523;4732.881677958078;4735;4785.162596545661;4754.952450475451;4761.095391875671;4765.618750500021;4766.213574760126;4810.254410566367;4704.223803072455;4706.129366067288;4708.105459962596;4730.148573256847;4740.644451666208;4645.6515761318715;4722.929156062593;4782.736949467812;4783.832565860178;4787.305840653016;4605.2401353777595;4612.7001744886475;4617.8152873884665;4644.8142074318;4668.183067963025 20:17:53 INFO - PROCESS | 6721 | |1;ext.html;546.9015577196108;547.0754425021713;568.3833041150351;569.4561693582629;594.753177431366;26777.196684099483;27135.728642713566;27176;27201.455970880594;37827.810860945654;40350.19299614013;41089.58910410895;41106.17787644245;41122.38316425256;41145.17709645805;7857.096433910102;8062.234087761653;8073.919260807375;8076.515409075445;8077.555734434603;7798.4930979486435;7917.722879699211;7937.4840635358805;7940.2853743163105;7943.523388596703;7922.920770792305;8006.399520035991;8018.959905200466;8022.598870056503;8025.277725004748;7887.171846956073;7951.165127661628;7951.920480795234;7952.4830885992515;7955.323797477221;7928.405369597245;8062.879056814152;8062.959685201537;8064.959675201645;8066.193380661945;39029;39527.604723952965;39553.20893582112;39554.40668389977;39556.208875822325;2840.062779282832;2840.2757296889367;2906.636670416198;3039.4984827503436;3163.810171389724;29506.85246573775;29722;29734.70265297341;29777.70222297771;29844.40311193764;3450.27544215715;3523.9647603523895;3582.1940063485767;3599.892003239907;3634.2368102698465;235579;237061;237774;237862.10689465457;239303;46409;54228;54753.726231368586;54756.72621636866;54780.452195478334;43220.3516947246;58134;59075.409245906994;59139.70430147822;59221.70389148027;13457.798133028013;13470.912008638677;13527.188368697909;13575.185488870502;13581.796273055912;7839.137694853562;10897.727556811144;10992.615258465916;11013.174011948975;11017.83473247902;18657.346992855186;18807.90596047011;18876.24495020211;18964.905175474036;19163.520911977033;6811.284815094443;6952.339527744856;6989.405900498413;7012.684429200698;7171.462140339496;806.8184658451802;897.6588896219525;901.8872640919885;953.0755167487526;1003.8694969653898;26514.469710606067;26620;26947.326316842235;26990;27131.86434067817;892.1034360467688;918.9402688825205;921.9400738951947;972.3096601412934;985.6205360935948;13800.585982420544;14014.649633759238;14220.786688199685;14466.566003019927;14478.782818257734;296217;297286;299403;302017;302050;46849.76575117103;47642.76178619154;47721;47768;47782.76108619435;1112.249231768553;1192.983857281192;1208.3656080557778;1220.5911019808286;1226.957056503018;24816.379590510383;24942.12702555402;25067.623985640595;25226.36934076663;25262.368440788392;35155;35655.82172089123;35681.82159089188;35688.643113568534;35728;169126;202219;202593;202967;203027;29686;30939.226519337197;30996.535051973788;31180.53229201609;31199.376012480076;39184.21631567296;39348;39914;39966;40297.194056118125;32639.67360326366;32946.68213271442;33101.66898330986;33420.66579334273;33650.49524257089;32721.34557308888;33142.93709928143;33161.336773263916;33348.33303333968;33385.332293354484;36261.27477450489;36725;37037.07407314839;37039.8148009269;37594.43608345932;27810.304742381602;29718;29805.850970745007;30000.849995749883;30382.544261835646;24013.51972960496;24450.021999119836;24621.753782462663;24690.382740431633;25345.619815702412 20:17:53 INFO - PROCESS | 6721 | |2;jquery.html;339.3755489898586;340.4705682663458;342.92969941162056;347.51001088465256;348.4842433198864;15039.624009399757;15558.222088895553;16206.432774852883;16218.1080040598;16237.188140592982;15089.245537723125;15214.923925380384;15431.845681543182;15943.282552285145;16105.03369797813;4824.276358546211;4948.1093403187415;4966;4987.775550100254;5036.269740887569;4867.318575399447;4887.951120488803;4994.675346102492;5000.899982000358;5033.723145227011;4976.800927962877;4980.302757613937;4984.352034235562;4985;4987.501249875002;4759.405074365704;4888.975555122237;4900.7794649240695;4969.826056088038;4971.4034315882145;4292.270314046588;4302.720323178984;4305.117450922553;4313.741175529447;4348.826046958118;18778.906105469385;19224.71162932557;19558;19579.902100489548;19585.80414195854;1884.5006073390562;2038.8878611676353;2074.5539708962647;2078.771335153132;2516.811239157052;12590.81113783294;12792.872071279262;12814.80777788334;12994.220346779224;13349.39927703246;1722.9913850430667;1730.2041061111904;1759.727242277449;1810.6740786658397;1882.7270045843413;56240.43759562434;57036.71481642565;57248.42751572514;57739.13391299134;58774.70612646952;8915.73252802417;9003.954980225057;9116.954415227881;9292.907070929205;9331.486768227813;12290.324032178138;12305.93847030759;12325.691857703629;12376.566820161252;12408.255504669569;6973.093497845349;7102.686003089341;7195.928040719526;7343.742968996166;7358.1538123116525;7121.750738724119;7133.785986420416;7146.59401620811;7200.819979500449;7255.056842610533;5644.6330988485615;5672.914906276409;5675.091985282335;5704.600677952587;5730.1404789281105;1644.7039532884196;1667.9416220432227;1685.0816305113497;1699.6685646298854;1714.2200298863986;892.2415946445599;928.4058202750246;988.9258305627106;1006.3961623026125;1006.7885743993697;15762.448314309173;16030.438934637232;16093.597660058593;16130.516084517483;16352.83647163537;866.5970323799463;869.3870821071256;870.1472556894279;890.2610833008716;924.6916455646016;9063.13900179482;9303.58133883977;9404.90595094054;9458.03709735074;9617.855732164024;123365.38317308357;124911.3754431222;289237;401889;403782;64600.67699661566;64758;65545;65967.34032659612;66157.66921165363;871.2420194430886;952.0955092661999;952.1716106986827;979.9363041402286;984.6947446291673;11883.465244063866;14382.208978506282;14454.783178252545;14529.782053268998;14539.636509087357;31652.36695266128;31961.520577190895;32364.676353237108;32902.67097328996;34252;39366;39475.40786888256;39911.40132898067;45568;46682.53317466917;9650.179734722627;9687.41875487473;9739.269554783561;9972.102510774064;10020.048095430922;10623;11181.763647270416;11435.771284574095;11528.82706759416;11672.241304315192;6979.616121113388;9996;10000.849987250052;10048.638569935913;10063;9835.803283934138;9938.801223975335;9973.451460169761;10083;10156.695299141038;7622.123455802654;7813.570253636105;9912.553935073083;10135.7466063349;10434.530446130095;10780.892191077988;10818.350898946088;10902.291351062155;11067.169962252703;11098.778024439305;10855.728606784578;10960.616378426717;10966.177536684621;11271.492782824957;11412.258203216765 20:17:53 INFO - PROCESS | 6721 | |3;mootools.html;1385.2311966858392;1416.8937329700273;1544.4671588302033;1721.1050253867998;1772.1493683032152;6927.099477067981;7108.218096009435;7117.395021423185;7145.928540714592;7159.677814498354;5947.167396564484;6619.139511863451;6704.5306828522025;6775.525713200066;7092.96453517733;2208.2712704807414;2234.6312858378346;2237.3623517297574;2239.9104035838545;2241.9103235870625;2175.260411460103;2210.6794514795347;2237.2617036377956;2239.8880055997215;2240.092762431218;1885.2930151193302;2182.901769420372;2250.516139030108;2251.133313674239;2252.200468833565;2163.437506248371;2193.8573992690503;2212.7455342635644;2216.0360243294217;2216.966745498819;2176.55380646967;2183.945401364963;2183.951703182481;2188.84678072535;2189.168116115866;6940.271271516519;6997.580145191305;7018.368346848757;7018.473614478883;7175.354218120342;4341.565843415665;4458.8439404620685;4493.03399769048;4494.415725955605;4495.280755079171;2883.9134825955257;2902.2309088091674;3029.348690031654;3031.4543382191196;3035.711607397294;997.7505623594102;1006.4213077480478;1015.1827778638193;1021.8416145497459;1028.0695970147028;9718.708438746778;9719.708408747749;9724.902750972471;9730.513474326326;9738.46438445878;3981.064449854282;4084.7753373564146;4091.202215567995;4167.437395951569;4167.624913757776;8501.957490212633;8524.74425767228;8531.402801803813;8549.059603443617;8559.529225892637;4486.663500237495;4511.977440112779;4514.142312960527;4523.638108951276;4528.773561321987;4100.712950093465;4104.343305071175;4110.630043296058;4112.074783173762;4115.36211887158;3363.1928337198897;3462.4806279058344;3472.8089955052715;3482.407990641597;3507.4563442666426;1049.1711547877244;1132.53000004997;1139.2480962564669;1142.4344949250008;1154.4054811771944;973.6300205921705;976.2970661123979;998.6904059741504;1043.3062013760916;1206.7043574324346;6437.485001199892;6477.708503117371;6522.706478208492;6532.150820393414;6537.738490460329;965.5365424596092;972.9075737804898;986.2504496582505;990.2968892086699;1031.6853359725355;5000.524950129732;5053.292539044537;5057.974710126499;5122.615803814729;5128.948710512922;8256.050554186226;8295.502269863828;8452.112528184574;8465.703700370457;8494.787630309169;8164.346852251806;8175.3459723222;8231.753047408587;8238.8352232955;8279.62741676626;6756.594604323756;6817.625030623264;6977.372036516738;6997.440204783605;7054.894176587355;6829.795106146824;6854.5201835873;6855.211650660238;6884.4148247399535;6944.791656250321;7639;7948;7967.56178410193;8078.272955434039;8118.553479558444;8022.318102961313;8096.676132954616;8106.270435660819;8222.917770822216;8289.212524810133;6341.841453963688;6362.268339140873;6421.903671445026;6430.164078669743;6472;6727.697253623501;6778.254392016973;6803.965980170067;6807.693653785691;6815.182178138655;5748.885022299614;6044.516438684806;6292.182016337847;6299.590526615755;6310.589811662411;5349.251104845247;6126.816195514141;6169.043798211284;6197.25632924052;6232.470240029467;6403.3276505966205;6443.935560644333;6447.323031081669;6466.644334561644;6505.934940650533;5968.8806223876145;6006.279246490449;6011;6015.308239552507;6029.487493563096;5923.881522369615;6020.638761674313;6082.847928801639;6194.473469755121;6222.408871157233 20:17:53 INFO - PROCESS | 6721 | |4;prototype.html;303.7903846346021;306.8542442339889;311.14125014958705;311.80200572636375;315.2559958497946;5246.160614301708;5256.211568264757;5273.6572122811995;5276.604254680895;5297.788088476461;5202.0376230397305;5207.609429292808;5224.582033437326;5236.8690782730455;5245.527902488775;3942.3495123304765;3991.501062367204;4085.3871919212206;4103.610157035077;4116.876493705194;4128.710990230685;4134.710570260083;4135.875923722293;4135.979320103395;4143.751374917515;4087;4088.407180958759;4093.099518106012;4100.79026687128;4101.507819061717;3870.748401353903;3986.800659967019;4053.2906741320444;4058.736182148151;4061.0862555924978;3541.7874927504176;3547.290541891632;3552.982235088834;3554.537910071674;3557.3063252665743;5025.0954828130925;5031.572316353115;5032.043911656773;5033.169527028036;5033.496650334974;4695.2252878275385;4696.530346965276;4698.718076915396;4700.600448961843;4706.905861882743;5576.33084029915;5581.776728930838;5585.776568937237;5627.409122042209;5643;3905.6875449963936;3914.5498267699295;3915.745476544044;3920.2551515212017;3922.2743792398496;5577.69322687252;5825.621334613236;5849.6197747146725;5855.531557475434;5876.236089308405;3920.137569734654;3945.8421663133727;3961.3463778476803;3966.7223294369696;3967.0677390813134;3974.503187101612;3993.3211354069877;3994.4407782910416;3995.5604883462797;3997.5003124609425;4625.236835922103;4626.797032771504;4627.722336659811;4632.25883858581;4666.883327916829;5583.888322233533;5592.412796656374;5593.608447408642;5594.1608758686525;5598.4961353477565;1377.7451171533298;1412.95054673088;1413.8444771075174;1417.9361928713026;1418.758811002132;912.739869137306;917.9036201198778;928.2620316848122;947.3557980573139;948.8576713492894;4831.806727730922;4854.83008094722;4857.004314115668;4865.464798872121;4867.050925069649;5700.429957004267;5725.427457254241;5765.509931655773;5785.71071446426;5788.797392091256;4825.5898248649255;4829.613630909519;4830.178869592178;4834.444038935497;4850.345203397566;3028.242939265184;3048.725614694688;3060.5256185291314;3069.2020074780717;3080.522519009557;5396.83809485716;5434.67391956476;5436.483534064337;5438;5440;5684.54523638108;5857.912131318034;5862.824115276549;5863.179154918314;5868.178455016301;5394.622376433612;5412.702301373383;5415.918761218585;5416.51251387377;5423.972880135653;5682.948654498931;5684.346300175533;5693.146028095819;5695.45893140151;5700.543956483554;5568.1091025435735;5577.358603760457;5577.414371490935;5586.273784408001;5592.944070559242;5395.973020134874;5400.0819860623005;5405.24326594285;5408.13469844823;5426.077566813572;3834.808259587065;3926.4895563577693;3930.508686414198;3941.0541470047556;3943.3493473576536;5656.915146272891;5687.687177205294;5689.118186681071;5757.165211044459;5762.625429347079;5282.630215885005;5456.236126942152;5566.749496272759;5581.6371935824045;5588.888222235614;5554.4445555445745;5567.55459563242;5570.582206334622;5575.414581469049;5577.498025177753;5495.422980586981;5501.972490137524;5504.779808807602;5506;5510.256115424367;5614.438556144353;5635.239242702347;5635.295588051494;5639.464250896158;5642.181883626933;5330.227117068081;5479.616426850242;5490.423505531861;5496.285482887199;5505.256790333414 20:17:53 INFO - PROCESS | 6721 | |5;yui.html;706.7985624097133;750.984980300394;782.5969625642795;783.9294463498284;793.3058573747973;11998.160128790989;12283.508659653626;12326.876731232685;12395.380230988438;12399.13206075575;11873.7625247495;12453.564125255618;12469.251844889313;12482.750344993095;12483.438245278961;649.6686689788219;793.9285464308211;818.472085504849;823.6458322921142;833.5832083958021;814.2183503836325;828.056016141599;830.6469750356105;831.7504748575434;831.9334453243725;843.1652663862793;858.1504310732392;859.2009431228954;861.4099341950753;861.7630151708267;673.9157605299338;837.1921096142252;842.0148426341165;868.4745728834027;869.7912500999714;622.439804176245;628.4940622798646;637.2957881540877;637.4326849104301;638.090720722968;12431.564895228623;12444.875551244462;12556;12611.36943152848;12642.103684447315;12536.874631253662;12830.743385132246;12833;12843.165194262436;12886.484540618458;9800.65697700577;9876.753081172956;9977.251706121997;10126;10156.796864062751;3132.2795756975797;3327.4010678077934;3349.514320423549;3402.3705614461405;3453.5510383650217;43016.99999999969;43807.78096109531;43869.122617547786;43886.34170487445;43981.56018439807;9614.423134611945;10030.498475076218;10053.597856085675;10171;10213.540390682438;17025.40411085606;17084.57288567771;17143;17176.055316957438;17176.82823171752;6791.796246112525;6909.343612356818;6922.930770692329;6944.4444444444325;7071.540349877241;3759.4548790425233;3763.1344790697744;3793.0517370657335;3825.6365645263654;3871.903202419962;2788.2750484874077;2840.1905456944673;2845.758110560584;2849.7577705894814;2852.8430936298705;498.35960790384183;505.6056276104644;508.0423401887469;509.7986295413291;516.1586613819525;598.6527813867946;614.2536817766346;618.1407843098098;624.7063879976404;637.7321524959528;7892.881606775903;8091.352691784643;8123.634436450374;8125.268725814705;8285.8342833143;497.4428639923237;512.2316525212182;540.2409614491645;631.9131094517422;636.688022868791;3257.2581283126374;3339.682730140633;3445.9483107753404;3688.2807852469045;3740.121071548184;54128.72935635375;54667.45332546624;54796.72601636966;54809.45190548123;55015.17477237764;44369;46205.30692039622;46356.3046554302;47026.294605580944;47137.05725885463;42725.145497089885;43017.35473967893;43144.56855431468;43250.783746081695;43506.78246608747;6490.286068532363;6515.990021546668;6520.641364724986;6621.735130594915;6657.1345725055435;30583.2354191147;31944.840275798473;32886.671133288364;33817.661823382434;33986.15034624154;40575.797121014206;40683.796581016904;41057.384139237336;41215.79392103021;41795;10606.734831629272;10683.5192416343;10725;10759.085477734166;10812.621558245424;11153.386563739072;11263.380514071478;11541.884581154081;11616.361100139573;11677.591284305008;10645.787084258116;10685.355781448687;10741.24811263204;10759.193060520649;10934;10638.361698298128;10723.30298530593;10916.50875710579;11040.558377664804;11486.138539609396;10519.263651544625;10669.626563070255;10670.786584268117;10692.1980851438;11000.614978476035;9061.22979546746;9302.441853488812;9330.953345233502;9481.715548533555;9486.905130948602;9388.24894008464;9547.33168678186;9611.807763844823;9617.855732164164;9811.852822207815 20:17:53 INFO - PROCESS | 6721 | __end_tp_report 20:17:53 INFO - PROCESS | 6721 | __start_cc_report 20:17:53 INFO - PROCESS | 6721 | _x_x_mozilla_cycle_collect,1061 20:17:53 INFO - PROCESS | 6721 | __end_cc_report 20:17:53 INFO - PROCESS | 6721 | __startTimestamp1459826273894__endTimestamp 20:17:53 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | ------- Summary: start ------- 20:17:53 INFO - PROCESS | 6721 | Number of tests: 6 20:17:53 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | [#0] dojo.html Cycles:165 Average:4495.34 Median:4617.82 stddev:470.53 (10.2%) stddev-sans-first:447.74 20:17:53 INFO - PROCESS | 6721 | Values: 2595.5 2623.1 2658.5 2658.7 2678.6 4488.4 4527.8 4543.8 4556.5 4573.6 4474.9 4506.5 4516.3 4554.6 4609.6 4112.8 4123.9 4144.5 4178.6 4313.0 4229.1 4267.6 4272.6 4316.1 4320.5 4075.3 4144.8 4158.1 4213.6 4215.5 4177.9 4216.8 4234.4 4255.3 4278.3 4180.7 4198.0 4208.5 4219.2 4238.4 4344.8 4414.7 4442.3 4483.2 4490.9 4831.0 4846.5 4853.2 4856.5 4893.8 4858.6 4863.8 4864.3 4865.8 4933.9 4450.6 4483.8 4547.9 4564.3 4588.5 4969.6 4978.5 5000.7 5001.5 5061.4 4795.4 4814.1 4814.6 4816.1 4865.3 4781.0 4863.5 4907.6 4952.3 4955.8 4846.5 4858.8 4870.5 4879.2 4924.2 4761.8 4846.7 4855.1 4860.7 4904.6 3877.2 3903.9 3933.3 3942.2 3946.3 3446.3 3451.2 3465.4 3504.7 3505.9 4126.4 4204.0 4206.1 4220.8 4266.3 4793.1 4836.0 4839.8 4851.6 4884.1 4207.5 4208.5 4227.4 4244.7 4275.3 4338.0 4414.1 4472.9 4485.1 4490.2 4605.9 4606.3 4659.9 4662.8 4674.0 4836.0 4842.6 4849.7 4857.0 4895.7 4469.0 4603.9 4619.4 4627.6 4667.7 4723.5 4761.6 4783.0 4818.2 4823.0 4856.0 4875.3 4876.1 4880.7 4932.9 4598.8 4660.6 4732.9 4735.0 4785.2 4755.0 4761.1 4765.6 4766.2 4810.3 4704.2 4706.1 4708.1 4730.1 4740.6 4645.7 4722.9 4782.7 4783.8 4787.3 4605.2 4612.7 4617.8 4644.8 4668.2 20:17:53 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | [#1] ext.html Cycles:180 Average:40498.93 Median:19339.48 stddev:64783.60 (335.0%) stddev-sans-first:64895.88 20:17:53 INFO - PROCESS | 6721 | Values: 546.9 547.1 568.4 569.5 594.8 26777.2 27135.7 27176.0 27201.5 37827.8 40350.2 41089.6 41106.2 41122.4 41145.2 7857.1 8062.2 8073.9 8076.5 8077.6 7798.5 7917.7 7937.5 7940.3 7943.5 7922.9 8006.4 8019.0 8022.6 8025.3 7887.2 7951.2 7951.9 7952.5 7955.3 7928.4 8062.9 8063.0 8065.0 8066.2 39029.0 39527.6 39553.2 39554.4 39556.2 2840.1 2840.3 2906.6 3039.5 3163.8 29506.9 29722.0 29734.7 29777.7 29844.4 3450.3 3524.0 3582.2 3599.9 3634.2 235579.0 237061.0 237774.0 237862.1 239303.0 46409.0 54228.0 54753.7 54756.7 54780.5 43220.4 58134.0 59075.4 59139.7 59221.7 13457.8 13470.9 13527.2 13575.2 13581.8 7839.1 10897.7 10992.6 11013.2 11017.8 18657.3 18807.9 18876.2 18964.9 19163.5 6811.3 6952.3 6989.4 7012.7 7171.5 806.8 897.7 901.9 953.1 1003.9 26514.5 26620.0 26947.3 26990.0 27131.9 892.1 918.9 921.9 972.3 985.6 13800.6 14014.6 14220.8 14466.6 14478.8 296217.0 297286.0 299403.0 302017.0 302050.0 46849.8 47642.8 47721.0 47768.0 47782.8 1112.2 1193.0 1208.4 1220.6 1227.0 24816.4 24942.1 25067.6 25226.4 25262.4 35155.0 35655.8 35681.8 35688.6 35728.0 169126.0 202219.0 202593.0 202967.0 203027.0 29686.0 30939.2 30996.5 31180.5 31199.4 39184.2 39348.0 39914.0 39966.0 40297.2 32639.7 32946.7 33101.7 33420.7 33650.5 32721.3 33142.9 33161.3 33348.3 33385.3 36261.3 36725.0 37037.1 37039.8 37594.4 27810.3 29718.0 29805.9 30000.8 30382.5 24013.5 24450.0 24621.8 24690.4 25345.6 20:17:53 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | [#2] jquery.html Cycles:180 Average:19872.80 Median:220900.20 stddev:49251.74 (22.3%) stddev-sans-first:49368.07 20:17:53 INFO - PROCESS | 6721 | Values: 339.4 340.5 342.9 347.5 348.5 15039.6 15558.2 16206.4 16218.1 16237.2 15089.2 15214.9 15431.8 15943.3 16105.0 4824.3 4948.1 4966.0 4987.8 5036.3 4867.3 4888.0 4994.7 5000.9 5033.7 4976.8 4980.3 4984.4 4985.0 4987.5 4759.4 4889.0 4900.8 4969.8 4971.4 4292.3 4302.7 4305.1 4313.7 4348.8 18778.9 19224.7 19558.0 19579.9 19585.8 1884.5 2038.9 2074.6 2078.8 2516.8 12590.8 12792.9 12814.8 12994.2 13349.4 1723.0 1730.2 1759.7 1810.7 1882.7 56240.4 57036.7 57248.4 57739.1 58774.7 8915.7 9004.0 9117.0 9292.9 9331.5 12290.3 12305.9 12325.7 12376.6 12408.3 6973.1 7102.7 7195.9 7343.7 7358.2 7121.8 7133.8 7146.6 7200.8 7255.1 5644.6 5672.9 5675.1 5704.6 5730.1 1644.7 1667.9 1685.1 1699.7 1714.2 892.2 928.4 988.9 1006.4 1006.8 15762.4 16030.4 16093.6 16130.5 16352.8 866.6 869.4 870.1 890.3 924.7 9063.1 9303.6 9404.9 9458.0 9617.9 123365.4 124911.4 289237.0 401889.0 403782.0 64600.7 64758.0 65545.0 65967.3 66157.7 871.2 952.1 952.2 979.9 984.7 11883.5 14382.2 14454.8 14529.8 14539.6 31652.4 31961.5 32364.7 32902.7 34252.0 39366.0 39475.4 39911.4 45568.0 46682.5 9650.2 9687.4 9739.3 9972.1 10020.0 10623.0 11181.8 11435.8 11528.8 11672.2 6979.6 9996.0 10000.8 10048.6 10063.0 9835.8 9938.8 9973.5 10083.0 10156.7 7622.1 7813.6 9912.6 10135.7 10434.5 10780.9 10818.4 10902.3 11067.2 11098.8 10855.7 10960.6 10966.2 11271.5 11412.3 20:17:53 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | [#3] mootools.html Cycles:180 Average:5036.93 Median:6181.76 stddev:2536.88 (41.0%) stddev-sans-first:2529.15 20:17:53 INFO - PROCESS | 6721 | Values: 1385.2 1416.9 1544.5 1721.1 1772.1 6927.1 7108.2 7117.4 7145.9 7159.7 5947.2 6619.1 6704.5 6775.5 7093.0 2208.3 2234.6 2237.4 2239.9 2241.9 2175.3 2210.7 2237.3 2239.9 2240.1 1885.3 2182.9 2250.5 2251.1 2252.2 2163.4 2193.9 2212.7 2216.0 2217.0 2176.6 2183.9 2184.0 2188.8 2189.2 6940.3 6997.6 7018.4 7018.5 7175.4 4341.6 4458.8 4493.0 4494.4 4495.3 2883.9 2902.2 3029.3 3031.5 3035.7 997.8 1006.4 1015.2 1021.8 1028.1 9718.7 9719.7 9724.9 9730.5 9738.5 3981.1 4084.8 4091.2 4167.4 4167.6 8502.0 8524.7 8531.4 8549.1 8559.5 4486.7 4512.0 4514.1 4523.6 4528.8 4100.7 4104.3 4110.6 4112.1 4115.4 3363.2 3462.5 3472.8 3482.4 3507.5 1049.2 1132.5 1139.2 1142.4 1154.4 973.6 976.3 998.7 1043.3 1206.7 6437.5 6477.7 6522.7 6532.2 6537.7 965.5 972.9 986.3 990.3 1031.7 5000.5 5053.3 5058.0 5122.6 5128.9 8256.1 8295.5 8452.1 8465.7 8494.8 8164.3 8175.3 8231.8 8238.8 8279.6 6756.6 6817.6 6977.4 6997.4 7054.9 6829.8 6854.5 6855.2 6884.4 6944.8 7639.0 7948.0 7967.6 8078.3 8118.6 8022.3 8096.7 8106.3 8222.9 8289.2 6341.8 6362.3 6421.9 6430.2 6472.0 6727.7 6778.3 6804.0 6807.7 6815.2 5748.9 6044.5 6292.2 6299.6 6310.6 5349.3 6126.8 6169.0 6197.3 6232.5 6403.3 6443.9 6447.3 6466.6 6505.9 5968.9 6006.3 6011.0 6015.3 6029.5 5923.9 6020.6 6082.8 6194.5 6222.4 20:17:53 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | [#4] prototype.html Cycles:180 Average:4592.52 Median:5251.19 stddev:1353.75 (25.8%) stddev-sans-first:1318.72 20:17:53 INFO - PROCESS | 6721 | Values: 303.8 306.9 311.1 311.8 315.3 5246.2 5256.2 5273.7 5276.6 5297.8 5202.0 5207.6 5224.6 5236.9 5245.5 3942.3 3991.5 4085.4 4103.6 4116.9 4128.7 4134.7 4135.9 4136.0 4143.8 4087.0 4088.4 4093.1 4100.8 4101.5 3870.7 3986.8 4053.3 4058.7 4061.1 3541.8 3547.3 3553.0 3554.5 3557.3 5025.1 5031.6 5032.0 5033.2 5033.5 4695.2 4696.5 4698.7 4700.6 4706.9 5576.3 5581.8 5585.8 5627.4 5643.0 3905.7 3914.5 3915.7 3920.3 3922.3 5577.7 5825.6 5849.6 5855.5 5876.2 3920.1 3945.8 3961.3 3966.7 3967.1 3974.5 3993.3 3994.4 3995.6 3997.5 4625.2 4626.8 4627.7 4632.3 4666.9 5583.9 5592.4 5593.6 5594.2 5598.5 1377.7 1413.0 1413.8 1417.9 1418.8 912.7 917.9 928.3 947.4 948.9 4831.8 4854.8 4857.0 4865.5 4867.1 5700.4 5725.4 5765.5 5785.7 5788.8 4825.6 4829.6 4830.2 4834.4 4850.3 3028.2 3048.7 3060.5 3069.2 3080.5 5396.8 5434.7 5436.5 5438.0 5440.0 5684.5 5857.9 5862.8 5863.2 5868.2 5394.6 5412.7 5415.9 5416.5 5424.0 5682.9 5684.3 5693.1 5695.5 5700.5 5568.1 5577.4 5577.4 5586.3 5592.9 5396.0 5400.1 5405.2 5408.1 5426.1 3834.8 3926.5 3930.5 3941.1 3943.3 5656.9 5687.7 5689.1 5757.2 5762.6 5282.6 5456.2 5566.7 5581.6 5588.9 5554.4 5567.6 5570.6 5575.4 5577.5 5495.4 5502.0 5504.8 5506.0 5510.3 5614.4 5635.2 5635.3 5639.5 5642.2 5330.2 5479.6 5490.4 5496.3 5505.3 20:17:53 INFO - PROCESS | 6721 | 20:17:53 INFO - PROCESS | 6721 | [#5] yui.html Cycles:180 Average:12874.61 Median:43378.78 stddev:14747.17 (34.0%) stddev-sans-first:14760.23 20:17:53 INFO - PROCESS | 6721 | Values: 706.8 751.0 782.6 783.9 793.3 11998.2 12283.5 12326.9 12395.4 12399.1 11873.8 12453.6 12469.3 12482.8 12483.4 649.7 793.9 818.5 823.6 833.6 814.2 828.1 830.6 831.8 831.9 843.2 858.2 859.2 861.4 861.8 673.9 837.2 842.0 868.5 869.8 622.4 628.5 637.3 637.4 638.1 12431.6 12444.9 12556.0 12611.4 12642.1 12536.9 12830.7 12833.0 12843.2 12886.5 9800.7 9876.8 9977.3 10126.0 10156.8 3132.3 3327.4 3349.5 3402.4 3453.6 43017.0 43807.8 43869.1 43886.3 43981.6 9614.4 10030.5 10053.6 10171.0 10213.5 17025.4 17084.6 17143.0 17176.1 17176.8 6791.8 6909.3 6922.9 6944.4 7071.5 3759.5 3763.1 3793.1 3825.6 3871.9 2788.3 2840.2 2845.8 2849.8 2852.8 498.4 505.6 508.0 509.8 516.2 598.7 614.3 618.1 624.7 637.7 7892.9 8091.4 8123.6 8125.3 8285.8 497.4 512.2 540.2 631.9 636.7 3257.3 3339.7 3445.9 3688.3 3740.1 54128.7 54667.5 54796.7 54809.5 55015.2 44369.0 46205.3 46356.3 47026.3 47137.1 42725.1 43017.4 43144.6 43250.8 43506.8 6490.3 6516.0 6520.6 6621.7 6657.1 30583.2 31944.8 32886.7 33817.7 33986.2 40575.8 40683.8 41057.4 41215.8 41795.0 10606.7 10683.5 10725.0 10759.1 10812.6 11153.4 11263.4 11541.9 11616.4 11677.6 10645.8 10685.4 10741.2 10759.2 10934.0 10638.4 10723.3 10916.5 11040.6 11486.1 10519.3 10669.6 10670.8 10692.2 11000.6 9061.2 9302.4 9331.0 9481.7 9486.9 9388.2 9547.3 9611.8 9617.9 9811.9 20:17:53 INFO - PROCESS | 6721 | -------- Summary: end -------- 20:17:53 INFO - PROCESS | 6721 | 20:17:54 INFO - TEST-INFO | 6721: exit 0 20:17:54 INFO - TEST-OK | dromaeo_css | took 1116186ms 20:17:54 INFO - TEST-START | kraken 20:17:54 INFO - operating with platform_type : linux_ 20:17:54 INFO - Initialising browser for kraken test... 20:17:54 INFO - TEST-INFO | started process 6901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIRdS97/profile http://localhost:48885/getInfo.html) 20:17:58 INFO - PROCESS | 6901 | __metrics Screen width/height:1600/1200 20:17:58 INFO - PROCESS | 6901 | colorDepth:24 20:17:58 INFO - PROCESS | 6901 | Browser inner width/height: 1024/697 20:17:58 INFO - PROCESS | 6901 | __metrics 20:17:59 ERROR - PROCESS | 6901 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:18:00 INFO - TEST-INFO | 6901: exit 0 20:18:00 INFO - Browser initialized. 20:18:00 INFO - Running cycle 1/1 for kraken test... 20:18:00 INFO - TEST-INFO | started process 6982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIRdS97/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:18:12 INFO - PROCESS | 6982 | RSS: Main: 154349568 20:18:12 INFO - PROCESS | 6982 | 20:18:15 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48885/tests/kraken/driver.html?testName=audio-beat-detection) 20:18:15 INFO - PROCESS | 6982 | RSS: Main: 195919872 20:18:15 INFO - PROCESS | 6982 | 20:18:18 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48885/tests/kraken/driver.html?testName=audio-dft) 20:18:19 INFO - PROCESS | 6982 | RSS: Main: 185815040 20:18:19 INFO - PROCESS | 6982 | 20:18:22 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48885/tests/kraken/driver.html?testName=audio-fft) 20:18:22 INFO - PROCESS | 6982 | RSS: Main: 172605440 20:18:22 INFO - PROCESS | 6982 | 20:18:25 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48885/tests/kraken/driver.html?testName=audio-oscillator) 20:18:25 INFO - PROCESS | 6982 | RSS: Main: 173600768 20:18:25 INFO - PROCESS | 6982 | 20:18:27 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48885/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:18:28 INFO - PROCESS | 6982 | RSS: Main: 173006848 20:18:28 INFO - PROCESS | 6982 | 20:18:31 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48885/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:32 INFO - PROCESS | 6982 | RSS: Main: 173170688 20:18:32 INFO - PROCESS | 6982 | 20:18:35 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48885/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:36 INFO - PROCESS | 6982 | RSS: Main: 171626496 20:18:36 INFO - PROCESS | 6982 | 20:18:39 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48885/tests/kraken/driver.html?testName=json-parse-financial) 20:18:39 INFO - PROCESS | 6982 | RSS: Main: 172326912 20:18:39 INFO - PROCESS | 6982 | 20:18:41 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48885/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:42 INFO - PROCESS | 6982 | RSS: Main: 186748928 20:18:42 INFO - PROCESS | 6982 | 20:18:43 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48885/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:44 INFO - PROCESS | 6982 | RSS: Main: 185507840 20:18:44 INFO - PROCESS | 6982 | 20:18:46 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48885/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:47 INFO - PROCESS | 6982 | RSS: Main: 192413696 20:18:47 INFO - PROCESS | 6982 | 20:18:49 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:50 INFO - PROCESS | 6982 | RSS: Main: 199000064 20:18:50 INFO - PROCESS | 6982 | 20:18:52 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:53 INFO - PROCESS | 6982 | RSS: Main: 197775360 20:18:53 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | Cycle 1(1): loaded http://localhost:48885/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48885/tests/kraken/driver.html?testName=ai-astar) 20:18:55 INFO - PROCESS | 6982 | RSS: Main: 259534848 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | __start_tp_report 20:18:55 INFO - PROCESS | 6982 | _x_x_mozilla_page_load 20:18:55 INFO - PROCESS | 6982 | _x_x_mozilla_page_load_details 20:18:55 INFO - PROCESS | 6982 | |i|pagename|runs| 20:18:55 INFO - PROCESS | 6982 | |0;ai-astar;112;113;106;113;113;113;103;112;113;113 20:18:55 INFO - PROCESS | 6982 | |1;audio-beat-detection;153;141;161;175;134;153;158;136;184;132 20:18:55 INFO - PROCESS | 6982 | |2;audio-dft;161;162;160;161;163;165;162;163;162;164 20:18:55 INFO - PROCESS | 6982 | |3;audio-fft;73;73;73;157;75;74;74;73;160;74 20:18:55 INFO - PROCESS | 6982 | |4;audio-oscillator;93;95;144;94;93;95;135;94;93;153 20:18:55 INFO - PROCESS | 6982 | |5;imaging-gaussian-blur;117;117;116;117;116;117;118;117;117;117 20:18:55 INFO - PROCESS | 6982 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;148;146 20:18:55 INFO - PROCESS | 6982 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;96 20:18:55 INFO - PROCESS | 6982 | |8;json-parse-financial;67;66;66;65;65;66;65;73;64;62 20:18:55 INFO - PROCESS | 6982 | |9;json-stringify-tinderbox;63;65;65;63;64;64;64;64;65;64 20:18:55 INFO - PROCESS | 6982 | |10;stanford-crypto-aes;82;81;82;82;82;82;81;81;81;82 20:18:55 INFO - PROCESS | 6982 | |11;stanford-crypto-ccm;119;117;126;125;115;118;124;114;116;116 20:18:55 INFO - PROCESS | 6982 | |12;stanford-crypto-pbkdf2;141;129;137;137;137;128;141;137;141;137 20:18:55 INFO - PROCESS | 6982 | |13;stanford-crypto-sha256-iterative;69;68;68;67;67;65;66;66;68;67 20:18:55 INFO - PROCESS | 6982 | __end_tp_report 20:18:55 INFO - PROCESS | 6982 | __start_cc_report 20:18:55 INFO - PROCESS | 6982 | _x_x_mozilla_cycle_collect,1169 20:18:55 INFO - PROCESS | 6982 | __end_cc_report 20:18:55 INFO - PROCESS | 6982 | __startTimestamp1459826335345__endTimestamp 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | ------- Summary: start ------- 20:18:55 INFO - PROCESS | 6982 | Number of tests: 14 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.57 (3.2%) stddev-sans-first:3.77 20:18:55 INFO - PROCESS | 6982 | Values: 112.0 113.0 106.0 113.0 113.0 113.0 103.0 112.0 113.0 113.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:155.50 stddev:17.54 (11.3%) stddev-sans-first:18.60 20:18:55 INFO - PROCESS | 6982 | Values: 153.0 141.0 161.0 175.0 134.0 153.0 158.0 136.0 184.0 132.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.49 (0.9%) stddev-sans-first:1.51 20:18:55 INFO - PROCESS | 6982 | Values: 161.0 162.0 160.0 161.0 163.0 165.0 162.0 163.0 162.0 164.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#3] audio-fft Cycles:10 Average:90.60 Median:73.50 stddev:35.80 (48.7%) stddev-sans-first:37.40 20:18:55 INFO - PROCESS | 6982 | Values: 73.0 73.0 73.0 157.0 75.0 74.0 74.0 73.0 160.0 74.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.50 stddev:24.60 (26.3%) stddev-sans-first:25.41 20:18:55 INFO - PROCESS | 6982 | Values: 93.0 95.0 144.0 94.0 93.0 95.0 135.0 94.0 93.0 153.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:18:55 INFO - PROCESS | 6982 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 20:18:55 INFO - PROCESS | 6982 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 148.0 146.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:18:55 INFO - PROCESS | 6982 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:2.85 (4.3%) stddev-sans-first:2.99 20:18:55 INFO - PROCESS | 6982 | Values: 67.0 66.0 66.0 65.0 65.0 66.0 65.0 73.0 64.0 62.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 20:18:55 INFO - PROCESS | 6982 | Values: 63.0 65.0 65.0 63.0 64.0 64.0 64.0 64.0 65.0 64.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 20:18:55 INFO - PROCESS | 6982 | Values: 82.0 81.0 82.0 82.0 82.0 82.0 81.0 81.0 81.0 82.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:118.50 stddev:4.40 (3.7%) stddev-sans-first:4.66 20:18:55 INFO - PROCESS | 6982 | Values: 119.0 117.0 126.0 125.0 115.0 118.0 124.0 114.0 116.0 116.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.50 Median:137.00 stddev:4.60 (3.4%) stddev-sans-first:4.58 20:18:55 INFO - PROCESS | 6982 | Values: 141.0 129.0 137.0 137.0 137.0 128.0 141.0 137.0 141.0 137.0 20:18:55 INFO - PROCESS | 6982 | 20:18:55 INFO - PROCESS | 6982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.20 (1.8%) stddev-sans-first:1.05 20:18:55 INFO - PROCESS | 6982 | Values: 69.0 68.0 68.0 67.0 67.0 65.0 66.0 66.0 68.0 67.0 20:18:55 INFO - PROCESS | 6982 | -------- Summary: end -------- 20:18:55 INFO - PROCESS | 6982 | 20:18:56 INFO - TEST-INFO | 6982: exit 0 20:18:56 INFO - TEST-OK | kraken | took 61629ms 20:18:56 INFO - SUITE-END | took 1177s 20:18:56 INFO - Completed test suite (00:19:38) 20:18:56 INFO - javascript benchmark 20:18:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2595.493878693655, 2623.0819213275354, 2658.468306338733, 2658.73412658734, 2678.611601317809, 4488.394066800981, 4527.750973696446, 4543.840965566206, 4556.453225612927, 4573.565511276432, 4474.910501789962, 4506.481754598222, 4516.299973504104, 4554.635629149669, 4609.585137337639, 4112.773797441147, 4123.855665051724, 4144.544100148981, 4178.582141785812, 4312.97843510782, 4229.069604686979, 4267.615914567688, 4272.572742725718, 4316.136772645467, 4320.524742278362, 4075.266452038632, 4144.8134833932545, 4158.126793373395, 4213.557576454489, 4215.473065866767, 4177.874663760092, 4216.810243539048, 4234.407182994383, 4255.319148936186, 4278.336857787048, 4180.665546756252, 4198.03445207604, 4208.537060923296, 4219.156168766228, 4238.364245363189, 4344.782760861945, 4414.690971631987, 4442.311441726538, 4483.170613436525, 4490.865274041784, 4831.0, 4846.5153484651255, 4853.199222128344, 4856.490068542787, 4893.828715994959, 4858.587020103296, 4863.805447782084, 4864.294677271776, 4865.78103985318, 4933.925991110136, 4450.621697155746, 4483.798229079699, 4547.8635640930825, 4564.315352697122, 4588.541145885418, 4969.552740253323, 4978.452370239271, 5000.74996250186, 5001.474845141281, 5061.367329083864, 4795.424549054136, 4814.133455977958, 4814.5907597853875, 4816.109019831342, 4865.318855360252, 4780.95219047812, 4863.513648635108, 4907.5828554572545, 4952.331435256267, 4955.82654607087, 4846.491118432585, 4858.7570621468785, 4870.537298956593, 4879.243717223836, 4924.162892308316, 4761.833335833229, 4846.709197448165, 4855.053264613437, 4860.659753817269, 4904.607631389552, 3877.2245550889934, 3903.921921561553, 3933.252681990413, 3942.172143849766, 3946.2502124596235, 3446.3451944130534, 3451.188970591959, 3465.4108801503803, 3504.737144714157, 3505.9298814024087, 4126.381042843597, 4203.957960420418, 4206.11671548972, 4220.767857767853, 4266.253405653998, 4793.13723529768, 4835.95164048362, 4839.830605928775, 4851.611871050378, 4884.096442158212, 4207.495100587949, 4208.494980602347, 4227.365895115758, 4244.745315281093, 4275.273203555403, 4337.956620433818, 4414.050979039458, 4472.932906006413, 4485.125400546862, 4490.191765482179, 4605.861824145281, 4606.332081848181, 4659.860204193879, 4662.813487460464, 4673.976630116827, 4835.975820120877, 4842.612590992782, 4849.733264670477, 4857.0, 4895.681780684244, 4469.039156581351, 4603.907921841477, 4619.376384188092, 4627.6066534344955, 4667.719936803803, 4723.504032076583, 4761.595264402426, 4783.043391321819, 4818.180909245507, 4823.03539292136, 4856.004519073652, 4875.268709693574, 4876.146674331907, 4880.682755620874, 4932.901341973069, 4598.816047358202, 4660.557247061523, 4732.881677958078, 4735.0, 4785.162596545661, 4754.952450475451, 4761.095391875671, 4765.618750500021, 4766.213574760126, 4810.254410566367, 4704.223803072455, 4706.129366067288, 4708.105459962596, 4730.148573256847, 4740.644451666208, 4645.6515761318715, 4722.929156062593, 4782.736949467812, 4783.832565860178, 4787.305840653016, 4605.2401353777595, 4612.7001744886475, 4617.8152873884665, 4644.8142074318, 4668.183067963025], "unit": "score", "name": "dojo.html", "value": 4465.9704822423055}, {"lowerIsBetter": false, "replicates": [546.9015577196108, 547.0754425021713, 568.3833041150351, 569.4561693582629, 594.753177431366, 26777.196684099483, 27135.728642713566, 27176.0, 27201.455970880594, 37827.810860945654, 40350.19299614013, 41089.58910410895, 41106.17787644245, 41122.38316425256, 41145.17709645805, 7857.096433910102, 8062.234087761653, 8073.919260807375, 8076.515409075445, 8077.555734434603, 7798.4930979486435, 7917.722879699211, 7937.4840635358805, 7940.2853743163105, 7943.523388596703, 7922.920770792305, 8006.399520035991, 8018.959905200466, 8022.598870056503, 8025.277725004748, 7887.171846956073, 7951.165127661628, 7951.920480795234, 7952.4830885992515, 7955.323797477221, 7928.405369597245, 8062.879056814152, 8062.959685201537, 8064.959675201645, 8066.193380661945, 39029.0, 39527.604723952965, 39553.20893582112, 39554.40668389977, 39556.208875822325, 2840.062779282832, 2840.2757296889367, 2906.636670416198, 3039.4984827503436, 3163.810171389724, 29506.85246573775, 29722.0, 29734.70265297341, 29777.70222297771, 29844.40311193764, 3450.27544215715, 3523.9647603523895, 3582.1940063485767, 3599.892003239907, 3634.2368102698465, 235579.0, 237061.0, 237774.0, 237862.10689465457, 239303.0, 46409.0, 54228.0, 54753.726231368586, 54756.72621636866, 54780.452195478334, 43220.3516947246, 58134.0, 59075.409245906994, 59139.70430147822, 59221.70389148027, 13457.798133028013, 13470.912008638677, 13527.188368697909, 13575.185488870502, 13581.796273055912, 7839.137694853562, 10897.727556811144, 10992.615258465916, 11013.174011948975, 11017.83473247902, 18657.346992855186, 18807.90596047011, 18876.24495020211, 18964.905175474036, 19163.520911977033, 6811.284815094443, 6952.339527744856, 6989.405900498413, 7012.684429200698, 7171.462140339496, 806.8184658451802, 897.6588896219525, 901.8872640919885, 953.0755167487526, 1003.8694969653898, 26514.469710606067, 26620.0, 26947.326316842235, 26990.0, 27131.86434067817, 892.1034360467688, 918.9402688825205, 921.9400738951947, 972.3096601412934, 985.6205360935948, 13800.585982420544, 14014.649633759238, 14220.786688199685, 14466.566003019927, 14478.782818257734, 296217.0, 297286.0, 299403.0, 302017.0, 302050.0, 46849.76575117103, 47642.76178619154, 47721.0, 47768.0, 47782.76108619435, 1112.249231768553, 1192.983857281192, 1208.3656080557778, 1220.5911019808286, 1226.957056503018, 24816.379590510383, 24942.12702555402, 25067.623985640595, 25226.36934076663, 25262.368440788392, 35155.0, 35655.82172089123, 35681.82159089188, 35688.643113568534, 35728.0, 169126.0, 202219.0, 202593.0, 202967.0, 203027.0, 29686.0, 30939.226519337197, 30996.535051973788, 31180.53229201609, 31199.376012480076, 39184.21631567296, 39348.0, 39914.0, 39966.0, 40297.194056118125, 32639.67360326366, 32946.68213271442, 33101.66898330986, 33420.66579334273, 33650.49524257089, 32721.34557308888, 33142.93709928143, 33161.336773263916, 33348.33303333968, 33385.332293354484, 36261.27477450489, 36725.0, 37037.07407314839, 37039.8148009269, 37594.43608345932, 27810.304742381602, 29718.0, 29805.850970745007, 30000.849995749883, 30382.544261835646, 24013.51972960496, 24450.021999119836, 24621.753782462663, 24690.382740431633, 25345.619815702412], "unit": "score", "name": "ext.html", "value": 16778.544981345756}, {"lowerIsBetter": false, "replicates": [339.3755489898586, 340.4705682663458, 342.92969941162056, 347.51001088465256, 348.4842433198864, 15039.624009399757, 15558.222088895553, 16206.432774852883, 16218.1080040598, 16237.188140592982, 15089.245537723125, 15214.923925380384, 15431.845681543182, 15943.282552285145, 16105.03369797813, 4824.276358546211, 4948.1093403187415, 4966.0, 4987.775550100254, 5036.269740887569, 4867.318575399447, 4887.951120488803, 4994.675346102492, 5000.899982000358, 5033.723145227011, 4976.800927962877, 4980.302757613937, 4984.352034235562, 4985.0, 4987.501249875002, 4759.405074365704, 4888.975555122237, 4900.7794649240695, 4969.826056088038, 4971.4034315882145, 4292.270314046588, 4302.720323178984, 4305.117450922553, 4313.741175529447, 4348.826046958118, 18778.906105469385, 19224.71162932557, 19558.0, 19579.902100489548, 19585.80414195854, 1884.5006073390562, 2038.8878611676353, 2074.5539708962647, 2078.771335153132, 2516.811239157052, 12590.81113783294, 12792.872071279262, 12814.80777788334, 12994.220346779224, 13349.39927703246, 1722.9913850430667, 1730.2041061111904, 1759.727242277449, 1810.6740786658397, 1882.7270045843413, 56240.43759562434, 57036.71481642565, 57248.42751572514, 57739.13391299134, 58774.70612646952, 8915.73252802417, 9003.954980225057, 9116.954415227881, 9292.907070929205, 9331.486768227813, 12290.324032178138, 12305.93847030759, 12325.691857703629, 12376.566820161252, 12408.255504669569, 6973.093497845349, 7102.686003089341, 7195.928040719526, 7343.742968996166, 7358.1538123116525, 7121.750738724119, 7133.785986420416, 7146.59401620811, 7200.819979500449, 7255.056842610533, 5644.6330988485615, 5672.914906276409, 5675.091985282335, 5704.600677952587, 5730.1404789281105, 1644.7039532884196, 1667.9416220432227, 1685.0816305113497, 1699.6685646298854, 1714.2200298863986, 892.2415946445599, 928.4058202750246, 988.9258305627106, 1006.3961623026125, 1006.7885743993697, 15762.448314309173, 16030.438934637232, 16093.597660058593, 16130.516084517483, 16352.83647163537, 866.5970323799463, 869.3870821071256, 870.1472556894279, 890.2610833008716, 924.6916455646016, 9063.13900179482, 9303.58133883977, 9404.90595094054, 9458.03709735074, 9617.855732164024, 123365.38317308357, 124911.3754431222, 289237.0, 401889.0, 403782.0, 64600.67699661566, 64758.0, 65545.0, 65967.34032659612, 66157.66921165363, 871.2420194430886, 952.0955092661999, 952.1716106986827, 979.9363041402286, 984.6947446291673, 11883.465244063866, 14382.208978506282, 14454.783178252545, 14529.782053268998, 14539.636509087357, 31652.36695266128, 31961.520577190895, 32364.676353237108, 32902.67097328996, 34252.0, 39366.0, 39475.40786888256, 39911.40132898067, 45568.0, 46682.53317466917, 9650.179734722627, 9687.41875487473, 9739.269554783561, 9972.102510774064, 10020.048095430922, 10623.0, 11181.763647270416, 11435.771284574095, 11528.82706759416, 11672.241304315192, 6979.616121113388, 9996.0, 10000.849987250052, 10048.638569935913, 10063.0, 9835.803283934138, 9938.801223975335, 9973.451460169761, 10083.0, 10156.695299141038, 7622.123455802654, 7813.570253636105, 9912.553935073083, 10135.7466063349, 10434.530446130095, 10780.892191077988, 10818.350898946088, 10902.291351062155, 11067.169962252703, 11098.778024439305, 10855.728606784578, 10960.616378426717, 10966.177536684621, 11271.492782824957, 11412.258203216765], "unit": "score", "name": "jquery.html", "value": 7994.691020454106}, {"lowerIsBetter": false, "replicates": [1385.2311966858392, 1416.8937329700273, 1544.4671588302033, 1721.1050253867998, 1772.1493683032152, 6927.099477067981, 7108.218096009435, 7117.395021423185, 7145.928540714592, 7159.677814498354, 5947.167396564484, 6619.139511863451, 6704.5306828522025, 6775.525713200066, 7092.96453517733, 2208.2712704807414, 2234.6312858378346, 2237.3623517297574, 2239.9104035838545, 2241.9103235870625, 2175.260411460103, 2210.6794514795347, 2237.2617036377956, 2239.8880055997215, 2240.092762431218, 1885.2930151193302, 2182.901769420372, 2250.516139030108, 2251.133313674239, 2252.200468833565, 2163.437506248371, 2193.8573992690503, 2212.7455342635644, 2216.0360243294217, 2216.966745498819, 2176.55380646967, 2183.945401364963, 2183.951703182481, 2188.84678072535, 2189.168116115866, 6940.271271516519, 6997.580145191305, 7018.368346848757, 7018.473614478883, 7175.354218120342, 4341.565843415665, 4458.8439404620685, 4493.03399769048, 4494.415725955605, 4495.280755079171, 2883.9134825955257, 2902.2309088091674, 3029.348690031654, 3031.4543382191196, 3035.711607397294, 997.7505623594102, 1006.4213077480478, 1015.1827778638193, 1021.8416145497459, 1028.0695970147028, 9718.708438746778, 9719.708408747749, 9724.902750972471, 9730.513474326326, 9738.46438445878, 3981.064449854282, 4084.7753373564146, 4091.202215567995, 4167.437395951569, 4167.624913757776, 8501.957490212633, 8524.74425767228, 8531.402801803813, 8549.059603443617, 8559.529225892637, 4486.663500237495, 4511.977440112779, 4514.142312960527, 4523.638108951276, 4528.773561321987, 4100.712950093465, 4104.343305071175, 4110.630043296058, 4112.074783173762, 4115.36211887158, 3363.1928337198897, 3462.4806279058344, 3472.8089955052715, 3482.407990641597, 3507.4563442666426, 1049.1711547877244, 1132.53000004997, 1139.2480962564669, 1142.4344949250008, 1154.4054811771944, 973.6300205921705, 976.2970661123979, 998.6904059741504, 1043.3062013760916, 1206.7043574324346, 6437.485001199892, 6477.708503117371, 6522.706478208492, 6532.150820393414, 6537.738490460329, 965.5365424596092, 972.9075737804898, 986.2504496582505, 990.2968892086699, 1031.6853359725355, 5000.524950129732, 5053.292539044537, 5057.974710126499, 5122.615803814729, 5128.948710512922, 8256.050554186226, 8295.502269863828, 8452.112528184574, 8465.703700370457, 8494.787630309169, 8164.346852251806, 8175.3459723222, 8231.753047408587, 8238.8352232955, 8279.62741676626, 6756.594604323756, 6817.625030623264, 6977.372036516738, 6997.440204783605, 7054.894176587355, 6829.795106146824, 6854.5201835873, 6855.211650660238, 6884.4148247399535, 6944.791656250321, 7639.0, 7948.0, 7967.56178410193, 8078.272955434039, 8118.553479558444, 8022.318102961313, 8096.676132954616, 8106.270435660819, 8222.917770822216, 8289.212524810133, 6341.841453963688, 6362.268339140873, 6421.903671445026, 6430.164078669743, 6472.0, 6727.697253623501, 6778.254392016973, 6803.965980170067, 6807.693653785691, 6815.182178138655, 5748.885022299614, 6044.516438684806, 6292.182016337847, 6299.590526615755, 6310.589811662411, 5349.251104845247, 6126.816195514141, 6169.043798211284, 6197.25632924052, 6232.470240029467, 6403.3276505966205, 6443.935560644333, 6447.323031081669, 6466.644334561644, 6505.934940650533, 5968.8806223876145, 6006.279246490449, 6011.0, 6015.308239552507, 6029.487493563096, 5923.881522369615, 6020.638761674313, 6082.847928801639, 6194.473469755121, 6222.408871157233], "unit": "score", "name": "mootools.html", "value": 4185.36162805381}, {"lowerIsBetter": false, "replicates": [303.7903846346021, 306.8542442339889, 311.14125014958705, 311.80200572636375, 315.2559958497946, 5246.160614301708, 5256.211568264757, 5273.6572122811995, 5276.604254680895, 5297.788088476461, 5202.0376230397305, 5207.609429292808, 5224.582033437326, 5236.8690782730455, 5245.527902488775, 3942.3495123304765, 3991.501062367204, 4085.3871919212206, 4103.610157035077, 4116.876493705194, 4128.710990230685, 4134.710570260083, 4135.875923722293, 4135.979320103395, 4143.751374917515, 4087.0, 4088.407180958759, 4093.099518106012, 4100.79026687128, 4101.507819061717, 3870.748401353903, 3986.800659967019, 4053.2906741320444, 4058.736182148151, 4061.0862555924978, 3541.7874927504176, 3547.290541891632, 3552.982235088834, 3554.537910071674, 3557.3063252665743, 5025.0954828130925, 5031.572316353115, 5032.043911656773, 5033.169527028036, 5033.496650334974, 4695.2252878275385, 4696.530346965276, 4698.718076915396, 4700.600448961843, 4706.905861882743, 5576.33084029915, 5581.776728930838, 5585.776568937237, 5627.409122042209, 5643.0, 3905.6875449963936, 3914.5498267699295, 3915.745476544044, 3920.2551515212017, 3922.2743792398496, 5577.69322687252, 5825.621334613236, 5849.6197747146725, 5855.531557475434, 5876.236089308405, 3920.137569734654, 3945.8421663133727, 3961.3463778476803, 3966.7223294369696, 3967.0677390813134, 3974.503187101612, 3993.3211354069877, 3994.4407782910416, 3995.5604883462797, 3997.5003124609425, 4625.236835922103, 4626.797032771504, 4627.722336659811, 4632.25883858581, 4666.883327916829, 5583.888322233533, 5592.412796656374, 5593.608447408642, 5594.1608758686525, 5598.4961353477565, 1377.7451171533298, 1412.95054673088, 1413.8444771075174, 1417.9361928713026, 1418.758811002132, 912.739869137306, 917.9036201198778, 928.2620316848122, 947.3557980573139, 948.8576713492894, 4831.806727730922, 4854.83008094722, 4857.004314115668, 4865.464798872121, 4867.050925069649, 5700.429957004267, 5725.427457254241, 5765.509931655773, 5785.71071446426, 5788.797392091256, 4825.5898248649255, 4829.613630909519, 4830.178869592178, 4834.444038935497, 4850.345203397566, 3028.242939265184, 3048.725614694688, 3060.5256185291314, 3069.2020074780717, 3080.522519009557, 5396.83809485716, 5434.67391956476, 5436.483534064337, 5438.0, 5440.0, 5684.54523638108, 5857.912131318034, 5862.824115276549, 5863.179154918314, 5868.178455016301, 5394.622376433612, 5412.702301373383, 5415.918761218585, 5416.51251387377, 5423.972880135653, 5682.948654498931, 5684.346300175533, 5693.146028095819, 5695.45893140151, 5700.543956483554, 5568.1091025435735, 5577.358603760457, 5577.414371490935, 5586.273784408001, 5592.944070559242, 5395.973020134874, 5400.0819860623005, 5405.24326594285, 5408.13469844823, 5426.077566813572, 3834.808259587065, 3926.4895563577693, 3930.508686414198, 3941.0541470047556, 3943.3493473576536, 5656.915146272891, 5687.687177205294, 5689.118186681071, 5757.165211044459, 5762.625429347079, 5282.630215885005, 5456.236126942152, 5566.749496272759, 5581.6371935824045, 5588.888222235614, 5554.4445555445745, 5567.55459563242, 5570.582206334622, 5575.414581469049, 5577.498025177753, 5495.422980586981, 5501.972490137524, 5504.779808807602, 5506.0, 5510.256115424367, 5614.438556144353, 5635.239242702347, 5635.295588051494, 5639.464250896158, 5642.181883626933, 5330.227117068081, 5479.616426850242, 5490.423505531861, 5496.285482887199, 5505.256790333414], "unit": "score", "name": "prototype.html", "value": 4157.182015348213}, {"lowerIsBetter": false, "replicates": [706.7985624097133, 750.984980300394, 782.5969625642795, 783.9294463498284, 793.3058573747973, 11998.160128790989, 12283.508659653626, 12326.876731232685, 12395.380230988438, 12399.13206075575, 11873.7625247495, 12453.564125255618, 12469.251844889313, 12482.750344993095, 12483.438245278961, 649.6686689788219, 793.9285464308211, 818.472085504849, 823.6458322921142, 833.5832083958021, 814.2183503836325, 828.056016141599, 830.6469750356105, 831.7504748575434, 831.9334453243725, 843.1652663862793, 858.1504310732392, 859.2009431228954, 861.4099341950753, 861.7630151708267, 673.9157605299338, 837.1921096142252, 842.0148426341165, 868.4745728834027, 869.7912500999714, 622.439804176245, 628.4940622798646, 637.2957881540877, 637.4326849104301, 638.090720722968, 12431.564895228623, 12444.875551244462, 12556.0, 12611.36943152848, 12642.103684447315, 12536.874631253662, 12830.743385132246, 12833.0, 12843.165194262436, 12886.484540618458, 9800.65697700577, 9876.753081172956, 9977.251706121997, 10126.0, 10156.796864062751, 3132.2795756975797, 3327.4010678077934, 3349.514320423549, 3402.3705614461405, 3453.5510383650217, 43016.99999999969, 43807.78096109531, 43869.122617547786, 43886.34170487445, 43981.56018439807, 9614.423134611945, 10030.498475076218, 10053.597856085675, 10171.0, 10213.540390682438, 17025.40411085606, 17084.57288567771, 17143.0, 17176.055316957438, 17176.82823171752, 6791.796246112525, 6909.343612356818, 6922.930770692329, 6944.4444444444325, 7071.540349877241, 3759.4548790425233, 3763.1344790697744, 3793.0517370657335, 3825.6365645263654, 3871.903202419962, 2788.2750484874077, 2840.1905456944673, 2845.758110560584, 2849.7577705894814, 2852.8430936298705, 498.35960790384183, 505.6056276104644, 508.0423401887469, 509.7986295413291, 516.1586613819525, 598.6527813867946, 614.2536817766346, 618.1407843098098, 624.7063879976404, 637.7321524959528, 7892.881606775903, 8091.352691784643, 8123.634436450374, 8125.268725814705, 8285.8342833143, 497.4428639923237, 512.2316525212182, 540.2409614491645, 631.9131094517422, 636.688022868791, 3257.2581283126374, 3339.682730140633, 3445.9483107753404, 3688.2807852469045, 3740.121071548184, 54128.72935635375, 54667.45332546624, 54796.72601636966, 54809.45190548123, 55015.17477237764, 44369.0, 46205.30692039622, 46356.3046554302, 47026.294605580944, 47137.05725885463, 42725.145497089885, 43017.35473967893, 43144.56855431468, 43250.783746081695, 43506.78246608747, 6490.286068532363, 6515.990021546668, 6520.641364724986, 6621.735130594915, 6657.1345725055435, 30583.2354191147, 31944.840275798473, 32886.671133288364, 33817.661823382434, 33986.15034624154, 40575.797121014206, 40683.796581016904, 41057.384139237336, 41215.79392103021, 41795.0, 10606.734831629272, 10683.5192416343, 10725.0, 10759.085477734166, 10812.621558245424, 11153.386563739072, 11263.380514071478, 11541.884581154081, 11616.361100139573, 11677.591284305008, 10645.787084258116, 10685.355781448687, 10741.24811263204, 10759.193060520649, 10934.0, 10638.361698298128, 10723.30298530593, 10916.50875710579, 11040.558377664804, 11486.138539609396, 10519.263651544625, 10669.626563070255, 10670.786584268117, 10692.1980851438, 11000.614978476035, 9061.22979546746, 9302.441853488812, 9330.953345233502, 9481.715548533555, 9486.905130948602, 9388.24894008464, 9547.33168678186, 9611.807763844823, 9617.855732164164, 9811.852822207815], "unit": "score", "name": "yui.html", "value": 5928.652763740975}], "name": "dromaeo_css", "value": 6287.829117525369}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 106.0, 113.0, 113.0, 113.0, 103.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [153.0, 141.0, 161.0, 175.0, 134.0, 153.0, 158.0, 136.0, 184.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 152.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 161.0, 163.0, 165.0, 162.0, 163.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 157.0, 75.0, 74.0, 74.0, 73.0, 160.0, 74.0], "unit": "score", "name": "audio-fft", "value": 90.6}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 144.0, 94.0, 93.0, 95.0, 135.0, 94.0, 93.0, 153.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 73.0, 64.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 65.9}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 65.0, 63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 82.0, 82.0, 82.0, 82.0, 81.0, 81.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 126.0, 125.0, 115.0, 118.0, 124.0, 114.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [141.0, 129.0, 137.0, 137.0, 137.0, 128.0, 141.0, 137.0, 141.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 67.0, 67.0, 65.0, 66.0, 66.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1518.2999999999997}]} 20:18:56 INFO - Return code: 0 20:18:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:18:56 ERROR - # TBPL SUCCESS # 20:18:56 INFO - Running post-action listener: _resource_record_post_action 20:18:56 INFO - Running post-run listener: _resource_record_post_run 20:18:57 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 421888; Write bytes: 519782400; Read time: 36; Write time: 497648 20:18:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232927232; Read time: 0; Write time: 287856 20:18:57 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 421888; Write bytes: 286683136; Read time: 36; Write time: 209776 20:18:57 INFO - Running post-run listener: _upload_blobber_files 20:18:57 INFO - Blob upload gear active. 20:18:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:18:57 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 20:18:57 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'] 20:18:57 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 20:18:58 INFO - (blobuploader) - INFO - Open directory for files ... 20:18:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:18:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:58 INFO - (blobuploader) - INFO - Done attempting. 20:18:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:18:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:18:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:59 INFO - (blobuploader) - INFO - Done attempting. 20:18:59 INFO - (blobuploader) - INFO - Iteration through files over. 20:18:59 INFO - Return code: 0 20:18:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:18:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:18:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9dfb3b0da1e6094c957683f6e831ca70a322c6dd5d7520c853bbca01e108a7e7c4266df3fd21fae7d0c3f0286e6eeb18fe63ad05830f683a070d43b4b04f63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/deb1585fe8a11a9509b1970c29673cbe71e8ce20fe97e3bc568637da6ae5ea7714be662d8e964a6beaab048d9ed9a2d7b58943cbf658d8bd95d2a1498af90c4f"} 20:18:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:18:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:18:59 INFO - Contents: 20:18:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9dfb3b0da1e6094c957683f6e831ca70a322c6dd5d7520c853bbca01e108a7e7c4266df3fd21fae7d0c3f0286e6eeb18fe63ad05830f683a070d43b4b04f63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/deb1585fe8a11a9509b1970c29673cbe71e8ce20fe97e3bc568637da6ae5ea7714be662d8e964a6beaab048d9ed9a2d7b58943cbf658d8bd95d2a1498af90c4f"} 20:18:59 INFO - Running post-run listener: copy_logs_to_upload_dir 20:18:59 INFO - Copying logs to upload dir... 20:18:59 INFO - mkdir: /builds/slave/test/build/upload/logs 20:18:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.382174 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-04 20:18:59.604879) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 20:18:59.608082) ========= 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-1459821743.879755-1112691247 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/f9dfb3b0da1e6094c957683f6e831ca70a322c6dd5d7520c853bbca01e108a7e7c4266df3fd21fae7d0c3f0286e6eeb18fe63ad05830f683a070d43b4b04f63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/deb1585fe8a11a9509b1970c29673cbe71e8ce20fe97e3bc568637da6ae5ea7714be662d8e964a6beaab048d9ed9a2d7b58943cbf658d8bd95d2a1498af90c4f"} build_url:https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/L_h7Xl4ATDahjPfYWsepow/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/f9dfb3b0da1e6094c957683f6e831ca70a322c6dd5d7520c853bbca01e108a7e7c4266df3fd21fae7d0c3f0286e6eeb18fe63ad05830f683a070d43b4b04f63c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/deb1585fe8a11a9509b1970c29673cbe71e8ce20fe97e3bc568637da6ae5ea7714be662d8e964a6beaab048d9ed9a2d7b58943cbf658d8bd95d2a1498af90c4f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-04 20:18:59.637443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 20:18:59.638234) ========= 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-1459821743.879755-1112691247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 20:18:59.719342) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 20:18:59.719810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 20:18:59.720120) ========= ========= Total master_lag: 0.32 =========