builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1458339794.82 results: success (0) buildid: 20160318144045 builduid: b801f2652057490794065a3b5a60c327 revision: 730802d0014eecf13e4d95668fc5265c416f7f9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.817177) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.817614) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.817899) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005900 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.871161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.871434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.915911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.916185) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.975110) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.975445) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.975798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:14.976110) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-18 15:23:14-- 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% 53.9M=0s 2016-03-18 15:23:15 (53.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.242734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.231486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.231798) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.121993 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.365258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.365569) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 730802d0014eecf13e4d95668fc5265c416f7f9b --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 730802d0014eecf13e4d95668fc5265c416f7f9b --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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-18 15:23:15,363 truncating revision to first 12 chars 2016-03-18 15:23:15,363 Setting DEBUG logging. 2016-03-18 15:23:15,363 attempt 1/10 2016-03-18 15:23:15,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/730802d0014e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 15:23:15,651 unpacking tar archive at: fx-team-730802d0014e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.941051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.941373) ========= echo 730802d0014eecf13e4d95668fc5265c416f7f9b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'730802d0014eecf13e4d95668fc5265c416f7f9b'] 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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 730802d0014eecf13e4d95668fc5265c416f7f9b program finished with exit code 0 elapsedTime=0.003278 script_repo_revision: '730802d0014eecf13e4d95668fc5265c416f7f9b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.989116) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.989399) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 15:23:15.999465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-03-18 15:23:15.999732) ========= /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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:23:16 INFO - MultiFileLogger online at 20160318 15:23:16 in /builds/slave/test 15:23:16 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 15:23:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:23:16 INFO - {'append_to_log': False, 15:23:16 INFO - 'base_work_dir': '/builds/slave/test', 15:23:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:23:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:23:16 INFO - 'branch': 'Fx-Team-Non-PGO', 15:23:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:23:16 INFO - 'config_files': ('talos/linux_config.py',), 15:23:16 INFO - 'default_actions': ('clobber', 15:23:16 INFO - 'read-buildbot-config', 15:23:16 INFO - 'download-and-extract', 15:23:16 INFO - 'populate-webroot', 15:23:16 INFO - 'create-virtualenv', 15:23:16 INFO - 'install', 15:23:16 INFO - 'run-tests'), 15:23:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:23:16 INFO - 'download_minidump_stackwalk': True, 15:23:16 INFO - 'download_symbols': 'ondemand', 15:23:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:23:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:23:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:23:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:23:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:23:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:23:16 INFO - 'installer_path': 'installer.exe', 15:23:16 INFO - 'log_level': 'info', 15:23:16 INFO - 'log_name': 'talos', 15:23:16 INFO - 'log_to_console': True, 15:23:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:23:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:23:16 INFO - 'opt_config_files': (), 15:23:16 INFO - 'pip_index': False, 15:23:16 INFO - 'sps_profile': False, 15:23:16 INFO - 'sps_profile_interval': 0, 15:23:16 INFO - 'suite': 'dromaeojs', 15:23:16 INFO - 'system_bits': '32', 15:23:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:23:16 INFO - 'title': 'talos-linux64-ix-036', 15:23:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:23:16 INFO - 'use_talos_json': True, 15:23:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:23:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:23:16 INFO - 'work_dir': 'build'} 15:23:16 INFO - ##### 15:23:16 INFO - ##### Running clobber step. 15:23:16 INFO - ##### 15:23:16 INFO - Running pre-action listener: _resource_record_pre_action 15:23:16 INFO - Running main action method: clobber 15:23:16 INFO - rmtree: /builds/slave/test/build 15:23:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:23:17 INFO - Running post-action listener: _resource_record_post_action 15:23:17 INFO - ##### 15:23:17 INFO - ##### Running read-buildbot-config step. 15:23:17 INFO - ##### 15:23:17 INFO - Running pre-action listener: _resource_record_pre_action 15:23:17 INFO - Running main action method: read_buildbot_config 15:23:17 INFO - Using buildbot properties: 15:23:17 INFO - { 15:23:17 INFO - "project": "", 15:23:17 INFO - "product": "firefox", 15:23:17 INFO - "script_repo_revision": "production", 15:23:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:23:17 INFO - "repository": "", 15:23:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:23:17 INFO - "buildid": "20160318144045", 15:23:17 INFO - "pgo_build": "False", 15:23:17 INFO - "basedir": "/builds/slave/test", 15:23:17 INFO - "buildnumber": 1477, 15:23:17 INFO - "slavename": "talos-linux64-ix-036", 15:23:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:23:17 INFO - "platform": "ubuntu64_hw", 15:23:17 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:23:17 INFO - "branch": "fx-team", 15:23:17 INFO - "repo_path": "integration/fx-team", 15:23:17 INFO - "revision": "730802d0014eecf13e4d95668fc5265c416f7f9b", 15:23:17 INFO - "stage_platform": "linux64", 15:23:17 INFO - "builduid": "b801f2652057490794065a3b5a60c327", 15:23:17 INFO - "slavebuilddir": "test" 15:23:17 INFO - } 15:23:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:23:17 INFO - Running post-action listener: _resource_record_post_action 15:23:17 INFO - ##### 15:23:17 INFO - ##### Running download-and-extract step. 15:23:17 INFO - ##### 15:23:17 INFO - Running pre-action listener: _resource_record_pre_action 15:23:17 INFO - Running main action method: download_and_extract 15:23:17 INFO - mkdir: /builds/slave/test/build/tests 15:23: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')]} 15:23:17 INFO - https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:20 INFO - Downloaded 1361 bytes. 15:23:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:23:20 INFO - Using the following test package requirements: 15:23:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:23:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:23:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:23:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:20 INFO - u'jsshell-linux-x86_64.zip'], 15:23:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:23:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:23:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:23:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:23:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:23:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:23:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:23:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:23:20 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')]} 15:23:20 INFO - https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:25 INFO - Downloaded 22009824 bytes. 15:23:25 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'] 15:23:25 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 15:23:26 INFO - Return code: 0 15:23:26 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 15:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:26 INFO - https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:32 INFO - Downloaded 22009824 bytes. 15:23:32 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'] 15:23:32 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 15:23:33 INFO - Return code: 0 15:23:33 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')]} 15:23:33 INFO - https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:23:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:23:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:23:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:35 INFO - Downloaded 10846565 bytes. 15:23:35 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'] 15:23:35 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 15:23:35 INFO - Return code: 0 15:23:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:35 INFO - https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:23:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:23:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:23:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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 15:23:36 INFO - Downloaded 54147718 bytes. 15:23:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:23:36 INFO - mkdir: /builds/slave/test/properties 15:23:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:23:36 INFO - Writing to file /builds/slave/test/properties/build_url 15:23:36 INFO - Contents: 15:23:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:23:37 INFO - Running post-action listener: _resource_record_post_action 15:23:37 INFO - Running post-action listener: set_extra_try_arguments 15:23:37 INFO - ##### 15:23:37 INFO - ##### Running populate-webroot step. 15:23:37 INFO - ##### 15:23:37 INFO - Running pre-action listener: _resource_record_pre_action 15:23:37 INFO - Running main action method: populate_webroot 15:23:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:23:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:23:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:23:37 INFO - '--tppagecycles', 15:23:37 INFO - '7'], 15:23:37 INFO - 'tests': ['tsvgm']}}, 15:23:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:23:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:23:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:23:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:23:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:37 INFO - 'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:37 INFO - 'tests': ['damp', 'tps']}, 15:23:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:37 INFO - 'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['damp', 'tps']}, 15:23:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:23:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:23:37 INFO - 'other': {'tests': ['a11yr', 15:23:37 INFO - 'ts_paint', 15:23:37 INFO - 'tpaint', 15:23:37 INFO - 'sessionrestore', 15:23:37 INFO - 'sessionrestore_no_auto_restore', 15:23:37 INFO - 'tabpaint']}, 15:23:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['a11yr', 15:23:37 INFO - 'ts_paint', 15:23:37 INFO - 'tpaint', 15:23:37 INFO - 'sessionrestore', 15:23:37 INFO - 'sessionrestore_no_auto_restore', 15:23:37 INFO - 'tabpaint']}, 15:23:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['a11yr', 15:23:37 INFO - 'ts_paint', 15:23:37 INFO - 'tpaint', 15:23:37 INFO - 'sessionrestore', 15:23:37 INFO - 'sessionrestore_no_auto_restore', 15:23:37 INFO - 'tabpaint']}, 15:23:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['a11yr', 15:23:37 INFO - 'ts_paint', 15:23:37 INFO - 'tpaint', 15:23:37 INFO - 'sessionrestore', 15:23:37 INFO - 'sessionrestore_no_auto_restore', 15:23:37 INFO - 'tabpaint']}, 15:23:37 INFO - 'other_l64': {'tests': ['a11yr', 15:23:37 INFO - 'ts_paint', 15:23:37 INFO - 'tpaint', 15:23:37 INFO - 'sessionrestore', 15:23:37 INFO - 'sessionrestore_no_auto_restore', 15:23:37 INFO - 'tabpaint']}, 15:23:37 INFO - 'other_nol64': {'tests': ['a11yr', 15:23:37 INFO - 'ts_paint', 15:23:37 INFO - 'tpaint', 15:23:37 INFO - 'sessionrestore', 15:23:37 INFO - 'sessionrestore_no_auto_restore', 15:23:37 INFO - 'tabpaint']}, 15:23:37 INFO - 'svgr': {'tests': ['tsvgx', 15:23:37 INFO - 'tsvgr_opacity', 15:23:37 INFO - 'tart', 15:23:37 INFO - 'tscrollx', 15:23:37 INFO - 'cart']}, 15:23:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['tsvgx', 15:23:37 INFO - 'tsvgr_opacity', 15:23:37 INFO - 'tart', 15:23:37 INFO - 'tscrollx', 15:23:37 INFO - 'cart']}, 15:23:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:37 INFO - 'tests': ['tp5o']}, 15:23:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:37 INFO - 'talos_options': ['--e10s'], 15:23:37 INFO - 'tests': ['tp5o']}, 15:23:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:37 INFO - 'talos_options': ['--xperf_path', 15:23:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:37 INFO - 'tests': ['tp5n']}, 15:23:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:37 INFO - 'talos_options': ['--e10s', 15:23:37 INFO - '--xperf_path', 15:23:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:37 INFO - 'tests': ['tp5n']}}, 15:23:37 INFO - 'talos.zip': {'path': '', 15:23:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:23:37 INFO - Running post-action listener: _resource_record_post_action 15:23:37 INFO - ##### 15:23:37 INFO - ##### Running create-virtualenv step. 15:23:37 INFO - ##### 15:23:37 INFO - Running pre-action listener: _resource_record_pre_action 15:23:37 INFO - Running main action method: create_virtualenv 15:23:37 INFO - Creating virtualenv /builds/slave/test/build/venv 15:23: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 15:23:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:23:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:23:37 INFO - Using real prefix '/usr' 15:23:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:23:38 INFO - Installing distribute.............................................................................................................................................................................................done. 15:23:40 INFO - Installing pip.................done. 15:23:40 INFO - Return code: 0 15:23:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:40 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 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:23:40 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 15:23:40 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 15:23:40 INFO - Using env: {'DISPLAY': ':0', 15:23:40 INFO - 'HOME': '/home/cltbld', 15:23:40 INFO - 'LANG': 'en_US.UTF-8', 15:23:40 INFO - 'LANGUAGE': 'en_US:en', 15:23:40 INFO - 'LOGNAME': 'cltbld', 15:23:40 INFO - 'MAIL': '/var/mail/cltbld', 15:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:40 INFO - 'MOZ_NO_REMOTE': '1', 15:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:41 INFO - 'NO_EM_RESTART': '1', 15:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:41 INFO - 'PWD': '/builds/slave/test', 15:23:41 INFO - 'SHELL': '/bin/bash', 15:23:41 INFO - 'SHLVL': '1', 15:23:41 INFO - 'TERM': 'linux', 15:23:41 INFO - 'TMOUT': '86400', 15:23:41 INFO - 'USER': 'cltbld', 15:23:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:41 INFO - '_': '/tools/buildbot/bin/python'} 15:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:41 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 15:23:41 INFO - Cleaning up... 15:23:41 INFO - Return code: 0 15:23:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:41 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 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:23:41 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 15:23:41 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 15:23:41 INFO - Using env: {'DISPLAY': ':0', 15:23:41 INFO - 'HOME': '/home/cltbld', 15:23:41 INFO - 'LANG': 'en_US.UTF-8', 15:23:41 INFO - 'LANGUAGE': 'en_US:en', 15:23:41 INFO - 'LOGNAME': 'cltbld', 15:23:41 INFO - 'MAIL': '/var/mail/cltbld', 15:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:41 INFO - 'MOZ_NO_REMOTE': '1', 15:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:41 INFO - 'NO_EM_RESTART': '1', 15:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:41 INFO - 'PWD': '/builds/slave/test', 15:23:41 INFO - 'SHELL': '/bin/bash', 15:23:41 INFO - 'SHLVL': '1', 15:23:41 INFO - 'TERM': 'linux', 15:23:41 INFO - 'TMOUT': '86400', 15:23:41 INFO - 'USER': 'cltbld', 15:23:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:41 INFO - '_': '/tools/buildbot/bin/python'} 15:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:41 INFO - Downloading/unpacking psutil>=0.7.1 15:23:41 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 15:23:41 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 15:23:41 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 15:23:41 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 15:23:41 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 15:23:41 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 15:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:23:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:43 INFO - Installing collected packages: psutil 15:23:43 INFO - Running setup.py install for psutil 15:23:43 INFO - building 'psutil._psutil_linux' extension 15:23:43 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 15:23:46 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 15:23:46 INFO - building 'psutil._psutil_posix' extension 15:23:46 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 15:23:46 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 15:23:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:46 INFO - Successfully installed psutil 15:23:46 INFO - Cleaning up... 15:23:46 INFO - Return code: 0 15:23:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:46 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 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:23:46 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 15:23:46 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 15:23:46 INFO - Using env: {'DISPLAY': ':0', 15:23:46 INFO - 'HOME': '/home/cltbld', 15:23:46 INFO - 'LANG': 'en_US.UTF-8', 15:23:46 INFO - 'LANGUAGE': 'en_US:en', 15:23:46 INFO - 'LOGNAME': 'cltbld', 15:23:46 INFO - 'MAIL': '/var/mail/cltbld', 15:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:46 INFO - 'MOZ_NO_REMOTE': '1', 15:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:46 INFO - 'NO_EM_RESTART': '1', 15:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:46 INFO - 'PWD': '/builds/slave/test', 15:23:46 INFO - 'SHELL': '/bin/bash', 15:23:46 INFO - 'SHLVL': '1', 15:23:46 INFO - 'TERM': 'linux', 15:23:46 INFO - 'TMOUT': '86400', 15:23:46 INFO - 'USER': 'cltbld', 15:23:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:46 INFO - '_': '/tools/buildbot/bin/python'} 15:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:23:49 INFO - Installing collected packages: mozsystemmonitor 15:23:49 INFO - Running setup.py install for mozsystemmonitor 15:23:49 INFO - Successfully installed mozsystemmonitor 15:23:49 INFO - Cleaning up... 15:23:49 INFO - Return code: 0 15:23:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:23:49 INFO - Using env: {'DISPLAY': ':0', 15:23:49 INFO - 'HOME': '/home/cltbld', 15:23:49 INFO - 'LANG': 'en_US.UTF-8', 15:23:49 INFO - 'LANGUAGE': 'en_US:en', 15:23:49 INFO - 'LOGNAME': 'cltbld', 15:23:49 INFO - 'MAIL': '/var/mail/cltbld', 15:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:49 INFO - 'MOZ_NO_REMOTE': '1', 15:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:49 INFO - 'NO_EM_RESTART': '1', 15:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:49 INFO - 'PWD': '/builds/slave/test', 15:23:49 INFO - 'SHELL': '/bin/bash', 15:23:49 INFO - 'SHLVL': '1', 15:23:49 INFO - 'TERM': 'linux', 15:23:49 INFO - 'TMOUT': '86400', 15:23:49 INFO - 'USER': 'cltbld', 15:23:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:49 INFO - '_': '/tools/buildbot/bin/python'} 15:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:49 INFO - Downloading/unpacking blobuploader==1.2.4 15:23:49 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 15:23:49 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 15:23:49 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 15:23:49 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 15:23:49 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 15:23:49 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 15:23:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:23:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:23:52 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 15:23:52 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 15:23:52 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 15:23:52 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 15:23:52 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 15:23:52 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 15:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:23:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:23:52 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 15:23:52 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 15:23:52 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 15:23:52 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 15:23:52 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 15:23:52 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 15:23:52 INFO - Downloading docopt-0.6.1.tar.gz 15:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:23:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:23:53 INFO - Running setup.py install for blobuploader 15:23:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:23:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:23:53 INFO - Running setup.py install for requests 15:23:53 INFO - Running setup.py install for docopt 15:23:53 INFO - Successfully installed blobuploader requests docopt 15:23:53 INFO - Cleaning up... 15:23:53 INFO - Return code: 0 15:23:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:53 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 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:23:53 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 15:23:53 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 15:23:53 INFO - Using env: {'DISPLAY': ':0', 15:23:53 INFO - 'HOME': '/home/cltbld', 15:23:53 INFO - 'LANG': 'en_US.UTF-8', 15:23:53 INFO - 'LANGUAGE': 'en_US:en', 15:23:53 INFO - 'LOGNAME': 'cltbld', 15:23:53 INFO - 'MAIL': '/var/mail/cltbld', 15:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:53 INFO - 'MOZ_NO_REMOTE': '1', 15:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:53 INFO - 'NO_EM_RESTART': '1', 15:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:53 INFO - 'PWD': '/builds/slave/test', 15:23:53 INFO - 'SHELL': '/bin/bash', 15:23:53 INFO - 'SHLVL': '1', 15:23:53 INFO - 'TERM': 'linux', 15:23:53 INFO - 'TMOUT': '86400', 15:23:53 INFO - 'USER': 'cltbld', 15:23:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:53 INFO - '_': '/tools/buildbot/bin/python'} 15:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:53 INFO - Running setup.py (path:/tmp/pip-8adTYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:53 INFO - Running setup.py (path:/tmp/pip-W2MG0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:53 INFO - Running setup.py (path:/tmp/pip-3ad2dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:54 INFO - Running setup.py (path:/tmp/pip-2wUODP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:54 INFO - Running setup.py (path:/tmp/pip-uGtL2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:54 INFO - Running setup.py (path:/tmp/pip-cI2uHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:54 INFO - Running setup.py (path:/tmp/pip-tXj3XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:54 INFO - Running setup.py (path:/tmp/pip-wZMy0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:54 INFO - Running setup.py (path:/tmp/pip-_29GY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:54 INFO - Running setup.py (path:/tmp/pip-KstEmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:54 INFO - Running setup.py (path:/tmp/pip-dXTmlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:54 INFO - Running setup.py (path:/tmp/pip-RytZtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:54 INFO - Running setup.py (path:/tmp/pip-4LY7Uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:54 INFO - Running setup.py (path:/tmp/pip-6YjJJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:54 INFO - Running setup.py (path:/tmp/pip-_Q_ZPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:54 INFO - Running setup.py (path:/tmp/pip-5Vs18z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:54 INFO - Running setup.py (path:/tmp/pip-a4rIwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:23:55 INFO - Running setup.py install for manifestparser 15:23:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for mozcrash 15:23:55 INFO - Running setup.py install for mozdebug 15:23:55 INFO - Running setup.py install for mozdevice 15:23:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for mozfile 15:23:55 INFO - Running setup.py install for mozhttpd 15:23:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for mozinfo 15:23:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for mozInstall 15:23:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:23:55 INFO - Running setup.py install for mozleak 15:23:55 INFO - Running setup.py install for mozlog 15:23:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Running setup.py install for moznetwork 15:23:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Running setup.py install for mozprocess 15:23:56 INFO - Running setup.py install for mozprofile 15:23:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Running setup.py install for mozrunner 15:23:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Running setup.py install for mozscreenshot 15:23:56 INFO - Running setup.py install for moztest 15:23:56 INFO - Running setup.py install for mozversion 15:23:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:23:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:23:56 INFO - Cleaning up... 15:23:56 INFO - Return code: 0 15:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:56 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 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:23:56 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 15:23:56 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 15:23:56 INFO - Using env: {'DISPLAY': ':0', 15:23:56 INFO - 'HOME': '/home/cltbld', 15:23:56 INFO - 'LANG': 'en_US.UTF-8', 15:23:56 INFO - 'LANGUAGE': 'en_US:en', 15:23:56 INFO - 'LOGNAME': 'cltbld', 15:23:56 INFO - 'MAIL': '/var/mail/cltbld', 15:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:56 INFO - 'MOZ_NO_REMOTE': '1', 15:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:56 INFO - 'NO_EM_RESTART': '1', 15:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:56 INFO - 'PWD': '/builds/slave/test', 15:23:56 INFO - 'SHELL': '/bin/bash', 15:23:56 INFO - 'SHLVL': '1', 15:23:56 INFO - 'TERM': 'linux', 15:23:56 INFO - 'TMOUT': '86400', 15:23:56 INFO - 'USER': 'cltbld', 15:23:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:56 INFO - '_': '/tools/buildbot/bin/python'} 15:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:57 INFO - Running setup.py (path:/tmp/pip-k4gSI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:57 INFO - Running setup.py (path:/tmp/pip-EKw8tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:57 INFO - Running setup.py (path:/tmp/pip-n7ZfjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:57 INFO - Running setup.py (path:/tmp/pip-ChCmGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:57 INFO - Running setup.py (path:/tmp/pip-uml8Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:57 INFO - Running setup.py (path:/tmp/pip-BXm0qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:57 INFO - Running setup.py (path:/tmp/pip-C0y1wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:57 INFO - Running setup.py (path:/tmp/pip-N0Hv36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:57 INFO - Running setup.py (path:/tmp/pip-hNNImJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:57 INFO - Running setup.py (path:/tmp/pip-WZqd9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:57 INFO - Running setup.py (path:/tmp/pip-2WQwtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:57 INFO - Running setup.py (path:/tmp/pip-DMuaRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:57 INFO - Running setup.py (path:/tmp/pip-_inR5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:57 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)) 15:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:57 INFO - Running setup.py (path:/tmp/pip-j2YmLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:58 INFO - Running setup.py (path:/tmp/pip-_F4iBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:23:58 INFO - Running setup.py (path:/tmp/pip-eePyeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:23:58 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)) 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:23:58 INFO - Running setup.py (path:/tmp/pip-5UX3Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:23:58 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)) 15:23:58 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)) 15:23:58 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)) 15:23:58 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)) 15:23:58 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)) 15:23:58 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)) 15:23:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:24:00 INFO - Downloading blessings-1.6.tar.gz 15:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:00 INFO - Installing collected packages: blessings 15:24:00 INFO - Running setup.py install for blessings 15:24:00 INFO - Successfully installed blessings 15:24:00 INFO - Cleaning up... 15:24:00 INFO - Return code: 0 15:24:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:00 INFO - Reading from file tmpfile_stdout 15:24:00 INFO - Current package versions: 15:24:00 INFO - argparse == 1.2.1 15:24:00 INFO - blessings == 1.6 15:24:00 INFO - blobuploader == 1.2.4 15:24:00 INFO - docopt == 0.6.1 15:24:00 INFO - manifestparser == 1.1 15:24:00 INFO - mozInstall == 1.12 15:24:00 INFO - mozcrash == 0.17 15:24:00 INFO - mozdebug == 0.1 15:24:00 INFO - mozdevice == 0.48 15:24:00 INFO - mozfile == 1.2 15:24:00 INFO - mozhttpd == 0.7 15:24:00 INFO - mozinfo == 0.9 15:24:00 INFO - mozleak == 0.1 15:24:00 INFO - mozlog == 3.1 15:24:00 INFO - moznetwork == 0.27 15:24:00 INFO - mozprocess == 0.22 15:24:00 INFO - mozprofile == 0.28 15:24:00 INFO - mozrunner == 6.11 15:24:00 INFO - mozscreenshot == 0.1 15:24:00 INFO - mozsystemmonitor == 0.0 15:24:00 INFO - moztest == 0.7 15:24:00 INFO - mozversion == 1.4 15:24:00 INFO - psutil == 3.1.1 15:24:00 INFO - requests == 1.2.3 15:24:00 INFO - wsgiref == 0.1.2 15:24:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:00 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 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:24:00 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 15:24:00 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 15:24:00 INFO - Using env: {'DISPLAY': ':0', 15:24:00 INFO - 'HOME': '/home/cltbld', 15:24:00 INFO - 'LANG': 'en_US.UTF-8', 15:24:00 INFO - 'LANGUAGE': 'en_US:en', 15:24:00 INFO - 'LOGNAME': 'cltbld', 15:24:00 INFO - 'MAIL': '/var/mail/cltbld', 15:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:00 INFO - 'MOZ_NO_REMOTE': '1', 15:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:00 INFO - 'NO_EM_RESTART': '1', 15:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:00 INFO - 'PWD': '/builds/slave/test', 15:24:00 INFO - 'SHELL': '/bin/bash', 15:24:00 INFO - 'SHLVL': '1', 15:24:00 INFO - 'TERM': 'linux', 15:24:00 INFO - 'TMOUT': '86400', 15:24:00 INFO - 'USER': 'cltbld', 15:24:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:00 INFO - '_': '/tools/buildbot/bin/python'} 15:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 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)) 15:24:00 INFO - Cleaning up... 15:24:00 INFO - Return code: 0 15:24:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:24:00 INFO - Using env: {'DISPLAY': ':0', 15:24:00 INFO - 'HOME': '/home/cltbld', 15:24:00 INFO - 'LANG': 'en_US.UTF-8', 15:24:00 INFO - 'LANGUAGE': 'en_US:en', 15:24:00 INFO - 'LOGNAME': 'cltbld', 15:24:00 INFO - 'MAIL': '/var/mail/cltbld', 15:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:00 INFO - 'MOZ_NO_REMOTE': '1', 15:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:00 INFO - 'NO_EM_RESTART': '1', 15:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:00 INFO - 'PWD': '/builds/slave/test', 15:24:00 INFO - 'SHELL': '/bin/bash', 15:24:00 INFO - 'SHLVL': '1', 15:24:00 INFO - 'TERM': 'linux', 15:24:00 INFO - 'TMOUT': '86400', 15:24:00 INFO - 'USER': 'cltbld', 15:24:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:00 INFO - '_': '/tools/buildbot/bin/python'} 15:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:01 INFO - Downloading/unpacking jsonschema 15:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:02 INFO - Downloading/unpacking functools32 (from jsonschema) 15:24:02 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 15:24:02 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 15:24:02 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 15:24:02 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 15:24:02 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 15:24:02 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 15:24:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:03 INFO - warning: no files found matching '*.txt' 15:24:03 INFO - no previously-included directories found matching 'build' 15:24:03 INFO - no previously-included directories found matching 'dist' 15:24:03 INFO - no previously-included directories found matching '.git*' 15:24:03 INFO - Installing collected packages: jsonschema, functools32 15:24:03 INFO - Running setup.py install for functools32 15:24:03 INFO - warning: no files found matching '*.txt' 15:24:03 INFO - no previously-included directories found matching 'build' 15:24:03 INFO - no previously-included directories found matching 'dist' 15:24:03 INFO - no previously-included directories found matching '.git*' 15:24:03 INFO - Successfully installed jsonschema functools32 15:24:03 INFO - Cleaning up... 15:24:03 INFO - Return code: 0 15:24:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c86bd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffe5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', '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 15:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:24:03 INFO - Using env: {'DISPLAY': ':0', 15:24:03 INFO - 'HOME': '/home/cltbld', 15:24:03 INFO - 'LANG': 'en_US.UTF-8', 15:24:03 INFO - 'LANGUAGE': 'en_US:en', 15:24:03 INFO - 'LOGNAME': 'cltbld', 15:24:03 INFO - 'MAIL': '/var/mail/cltbld', 15:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:03 INFO - 'MOZ_NO_REMOTE': '1', 15:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:03 INFO - 'NO_EM_RESTART': '1', 15:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:03 INFO - 'PWD': '/builds/slave/test', 15:24:03 INFO - 'SHELL': '/bin/bash', 15:24:03 INFO - 'SHLVL': '1', 15:24:03 INFO - 'TERM': 'linux', 15:24:03 INFO - 'TMOUT': '86400', 15:24:03 INFO - 'USER': 'cltbld', 15:24:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:03 INFO - '_': '/tools/buildbot/bin/python'} 15:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:03 INFO - Downloading/unpacking flake8 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:24:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:24:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:24:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:24:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:24:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:24:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:24:06 INFO - no previously-included directories found matching 'docs/_build' 15:24:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:24:06 INFO - Running setup.py install for pep8 15:24:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:24:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:24:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:24:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:24:06 INFO - no previously-included directories found matching 'docs/_build' 15:24:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:24:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:24:06 INFO - Cleaning up... 15:24:06 INFO - Return code: 0 15:24:06 INFO - Running post-action listener: _resource_record_post_action 15:24:06 INFO - Running post-action listener: _start_resource_monitoring 15:24:06 INFO - Starting resource monitoring. 15:24:06 INFO - ##### 15:24:06 INFO - ##### Running install step. 15:24:06 INFO - ##### 15:24:06 INFO - Running pre-action listener: _resource_record_pre_action 15:24:06 INFO - Running main action method: install 15:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:06 INFO - Reading from file tmpfile_stdout 15:24:06 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:06 INFO - Reading from file tmpfile_stdout 15:24:06 INFO - Output received: 15:24:06 INFO - Usage: mozinstall [options] installer 15:24:06 INFO - Options: 15:24:06 INFO - -h, --help show this help message and exit 15:24:06 INFO - -d DEST, --destination=DEST 15:24:06 INFO - Directory to install application into. [default: 15:24:06 INFO - "/builds/slave/test"] 15:24:06 INFO - --app=APP Application being installed. [default: firefox] 15:24:06 INFO - mkdir: /builds/slave/test/build/application 15:24:06 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'] 15:24:06 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 15:24:22 INFO - Reading from file tmpfile_stdout 15:24:22 INFO - Output received: 15:24:22 INFO - /builds/slave/test/build/application/firefox/firefox 15:24:22 INFO - Running post-action listener: _resource_record_post_action 15:24:22 INFO - ##### 15:24:22 INFO - ##### Running run-tests step. 15:24:22 INFO - ##### 15:24:22 INFO - Running pre-action listener: _resource_record_pre_action 15:24:22 INFO - Running main action method: run_tests 15:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:24:22 INFO - Python 2.7.3 15:24:22 INFO - Return code: 0 15:24:22 INFO - grabbing minidump binary from tooltool 15:24:22 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')]} 15:24:22 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 0x208d410>, '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 0x208e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:24:22 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 15:24:22 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 15:24:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:24:22 INFO - Return code: 0 15:24:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:24:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:24:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:24:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:24:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:24:23 INFO - Return code: 0 15:24:23 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/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 15:24:23 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/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 15:24:23 INFO - Using env: {'DISPLAY': ':0', 15:24:23 INFO - 'HOME': '/home/cltbld', 15:24:23 INFO - 'LANG': 'en_US.UTF-8', 15:24:23 INFO - 'LANGUAGE': 'en_US:en', 15:24:23 INFO - 'LOGNAME': 'cltbld', 15:24:23 INFO - 'MAIL': '/var/mail/cltbld', 15:24:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:24:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:23 INFO - 'MOZ_NO_REMOTE': '1', 15:24:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:23 INFO - 'NO_EM_RESTART': '1', 15:24:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:23 INFO - 'PWD': '/builds/slave/test', 15:24:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:24:23 INFO - 'SHELL': '/bin/bash', 15:24:23 INFO - 'SHLVL': '1', 15:24:23 INFO - 'TERM': 'linux', 15:24:23 INFO - 'TMOUT': '86400', 15:24:23 INFO - 'USER': 'cltbld', 15:24:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307', 15:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:23 INFO - '_': '/tools/buildbot/bin/python'} 15:24:23 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/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 15:24:23 INFO - mozversion application_buildid: 20160318144045 15:24:23 INFO - mozversion application_changeset: 730802d0014eecf13e4d95668fc5265c416f7f9b 15:24:23 INFO - mozversion application_display_name: Nightly 15:24:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:24:23 INFO - mozversion application_name: Firefox 15:24:23 INFO - mozversion application_remotingname: firefox 15:24:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:24:23 INFO - mozversion application_vendor: Mozilla 15:24:23 INFO - mozversion application_version: 48.0a1 15:24:23 INFO - mozversion platform_buildid: 20160318144045 15:24:23 INFO - mozversion platform_changeset: 730802d0014eecf13e4d95668fc5265c416f7f9b 15:24:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:24:23 INFO - mozversion platform_version: 48.0a1 15:24:23 INFO - using testdate: 1458339863 15:24:23 INFO - actual date: 1458339863 15:24:23 INFO - starting webserver on 'localhost:50570' 15:24:23 INFO - SUITE-START | Running 2 tests 15:24:23 INFO - TEST-START | dromaeo_css 15:24:23 INFO - operating with platform_type : linux_ 15:24:23 INFO - Initialising browser for dromaeo_css test... 15:24:24 INFO - TEST-INFO | started process 3312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJVpBTd/profile http://localhost:50570/getInfo.html) 15:24:33 INFO - PROCESS | 3312 | __metrics Screen width/height:1600/1200 15:24:33 INFO - PROCESS | 3312 | colorDepth:24 15:24:33 INFO - PROCESS | 3312 | Browser inner width/height: 1024/697 15:24:33 INFO - PROCESS | 3312 | __metrics 15:24:34 ERROR - PROCESS | 3312 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:24:35 INFO - TEST-INFO | 3312: exit 0 15:24:35 INFO - Browser initialized. 15:24:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:35 INFO - TEST-INFO | started process 3406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJVpBTd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:47 INFO - PROCESS | 3406 | RSS: Main: 154800128 15:24:47 INFO - PROCESS | 3406 | 15:25:38 INFO - PROCESS | 3406 | 1458339938593 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] 15:27:50 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50570/tests/dromaeo/cssquery-ext.html) 15:27:51 INFO - PROCESS | 3406 | RSS: Main: 245399552 15:27:51 INFO - PROCESS | 3406 | 15:30:53 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-ext.html (next: http://localhost:50570/tests/dromaeo/cssquery-jquery.html) 15:30:54 INFO - PROCESS | 3406 | RSS: Main: 231141376 15:30:54 INFO - PROCESS | 3406 | 15:33:56 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50570/tests/dromaeo/cssquery-mootools.html) 15:33:56 INFO - PROCESS | 3406 | RSS: Main: 233299968 15:33:56 INFO - PROCESS | 3406 | 15:36:58 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50570/tests/dromaeo/cssquery-prototype.html) 15:36:59 INFO - PROCESS | 3406 | RSS: Main: 206311424 15:36:59 INFO - PROCESS | 3406 | 15:40:02 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50570/tests/dromaeo/cssquery-yui.html) 15:40:02 INFO - PROCESS | 3406 | RSS: Main: 207675392 15:40:02 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | Cycle 1(1): loaded http://localhost:50570/tests/dromaeo/cssquery-yui.html (next: http://localhost:50570/tests/dromaeo/cssquery-dojo.html) 15:43:05 INFO - PROCESS | 3406 | RSS: Main: 269516800 15:43:05 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | __start_tp_report 15:43:05 INFO - PROCESS | 3406 | _x_x_mozilla_page_load 15:43:05 INFO - PROCESS | 3406 | _x_x_mozilla_page_load_details 15:43:05 INFO - PROCESS | 3406 | |i|pagename|runs| 15:43:05 INFO - PROCESS | 3406 | |0;dojo.html;2576.5491039068156;2579.2906950588585;2588.7022992355874;2619.869006549672;2652.46950609878;4575.4509458864895;4667.043256132493;4694;4695.6478264130155;4704.529547045298;4693.577578017977;4734.1241870254025;4740.099381117585;4779.378680771503;4861.319415281854;4278.187144442553;4307.698461107724;4308.482982042159;4330.84842030529;4474.574915383034;4245.787710614457;4427.756473393962;4445.711028783135;4450.666200034994;4488.528704486031;4287.335463003224;4312.417823593806;4335.869923902288;4362.781860906942;4408.272635015219;4269.167512335096;4271.61555460007;4285.742855428684;4314.654827613784;4326.762028088454;4182.686298527623;4269.252880745857;4271.231178387889;4286.61420472159;4323.0705398339505;4573.314002899559;4603.677742558022;4625.352450656911;4660.04469083837;4670.6497012724185;5057.671251368649;5089.3638295213095;5089.949100508985;5105.617078719074;5139.871503212412;4919.1391506486225;5073.7209453480045;5131.435542090405;5134.229865520165;5142.588592912558;4805.1590971579835;4812.975935120302;4834.009028149221;4836.129496690559;4859.198232291667;5258.368995720538;5268.051750684914;5270.235815806686;5270.78916843322;5276.762545685453;4906.31311616374;5006.048850718352;5054.873628159252;5091.9236211456855;5110.693358398508;5087.923681144785;5094.414142373675;5100.387953445536;5105;5140;5062.341895553628;5066.695998240118;5072.847814565569;5077.492250774893;5096.184610462308;4857.101436234238;5054.721990290569;5060.822871199491;5091.0581542414775;5147.485251474897;4336.739795612273;4351.43431353922;4359.324304732771;4367.650587952956;4409.735415874994;3787.981060094682;3791.6208379162413;3809.2571948470336;3815.8664446744788;3828.8277027533827;4276.273033584298;4278.336857787048;4278.978605107017;4286.37847512109;4357.869263922087;4996;4997.725125118153;5001.72490513018;5004.4995500450395;5043.344365232496;4267.957320426818;4275.0594869128745;4278.294081476583;4284.507281662586;4321.740695558214;4421.204183246982;4446.244138496463;4453.933191002137;4472.530384309665;4502.594766471033;4669.626429885601;4683.344331793483;4686.554777296152;4692.788824502837;4728.95962888164;4825.131476334153;4953.133201689618;4967.05625931072;4976.32819569368;5022.924656130234;4719.811207551659;4731.313959475926;4733.408323959505;4761.357216775829;4779.641526885567;4824.6863953842885;4857.757112144308;4860.1008813369635;4861.927071094007;4905.23968784839;4849.733264670477;4925.9014819704125;4945.727984960718;4958.504149585013;4986.853023804472;4869.70781753096;4883.096627123993;4923.08922849274;4937.21004639256;4945.851624451272;4923.261510773269;4940.086084074458;4942.233953737176;4949.455559888482;4983.377077865267;4733.857984260478;4752.904941901212;4865.70805751656;4868.294097355934;4916.508349165055;4867.63492738039;4886.340344053508;4894.730789806595;4940.555350018516;4947.925781113358;4757.429108506863;4758.452777930583;4774.40319960005;4774.522547745198;4810.518948105161 15:43:05 INFO - PROCESS | 3406 | |1;ext.html;501.43087595579004;534.2493796216316;536.4769349883861;543.2259030880994;558.2129197831058;26293;26760.59154676079;34096.4885526717;34424.48363274553;34526;37332.626673733255;37895;37947.62052379475;38024.23951520968;38024.239515209745;7383.6677349519405;7617.504862183968;7803.648835802403;7810.921890781076;9588.328816982814;9712.951435242814;9872.210223182165;9874.456904870229;9875.308728389016;9875.654352097677;9793.853092203623;9820.558074886647;9825.557849896735;9831;9864.556094975744;9661.082197191256;9740.074692904163;9748.415095094317;9759.65841195562;9838.360506567122;9688.903110968871;10135.695929122137;10145.594176232942;10147.64483243083;10151.086402223762;37248.62751372479;37540.62459375426;37585.81207093947;37615;37632.24735505302;3247.318063206729;3287.819169945652;3301.092199645093;3330.7668463207583;3365.2259980204444;29130.563041554393;29446;29881.25296867574;30175.396492070256;30809.383812323853;3308.9007329780147;3356.597208334991;3373.477111047767;3384.3231353729107;3405.676460736226;184704;273508;275497;275880;276214;56187;57392;57560.42439575551;57570;57616.71191644015;60997;61638.38361616416;61653;61729.691351542955;61753;12778.61664150077;12888.162269452456;12889.677758056123;12950.805737913939;12978.545750898673;9272.907270927339;10717.83923241152;11082;11087.168462365355;11145.665630031112;19148.425547233604;19178.80821191798;19349.322773702854;19393.709094363596;19419.8058019418;7528.736494222676;7722.806929826799;7745.22547745221;7800.45396822217;7906.288434040964;809.283783851284;895.8432274351962;908.8773015642936;1002.8295189817749;1007.8034783217203;26260.73739262621;26805.195844124708;27238;27300.72699272982;27394.315142121606;982.4498280962683;997.7006897930592;1024.4979959819634;1040.95836166554;1048.5438834107188;13734.175949442866;13768.931155344158;14128;14270.643233919027;14450.566483005527;290664;295309;295506;296340;296688;45845;46383.76808115938;46390.07219855652;46394;46403.5359646406;1123.4045955643521;1195.0618764270007;1237.616338934933;1238.851337839465;1241.838560987084;23988.51967346609;26225.737742623092;27585.724142758314;27643.756030979057;27716.722832771415;37161.814190928875;43101.56898430976;43993.34009989789;43998;44051.77974110237;279100;281646;283279;283371;283921;34214.31571368608;38948.6105138945;40311.3953290695;40368.596314036484;40980.59019409887;36613.26773464462;36687.816560918094;36730.26539469249;37410.62589374071;37431;30430;32265.35469290648;32341.676583234806;32456.83771581127;33045.83477082695;32165;32566.674333256364;32615.836920815244;32760.50859237161;32774.67225327811;33826;34079.318413632085;34182.31635367229;34755.13112172216;35077.64922350744;30452.695473044987;30838.845805770827;30861.228469288446;31201;31366.215844604067;24292.514149716553;24406.633900491153;24633;24792.752072479045;24883.502329953662 15:43:05 INFO - PROCESS | 3406 | |2;jquery.html;349.46880741273264;357.07517529598334;362.4327926794567;362.9437437197234;369.2338397824513;15516.689666206668;15547.533573992785;16612.66774664506;16682.66634667306;16874.409395671155;15537.14545699986;15742.449014284502;16323.183840807971;16339.428120015802;16342;4897.289892965527;5015.197568389059;5021.799128034874;5027.145385284511;5298.576113910878;5206.687598744069;5217.478252174771;5221.347331583552;5242.135047717122;5243.10867152585;5057.620678449131;5211.5049070338255;5213.556847667953;5215.452377500345;5216.973915130419;5209.817656382027;5216.452272511369;5238.973805130988;5243.501867322599;5244.423113457517;4946.109700253953;5054.418741844698;5062.139436295838;5065.772040258161;5070.898582028376;12383.133180677356;12630.431630576555;12655.557055503014;12664.11351205416;12687.238765674088;1937.7771556270927;1957.0508303472805;1964.9705254421194;2008.096356639518;2117.8941052947443;9083.591238394289;9249.491277979709;9537.952310238474;9546.522673866279;10162.59349626014;1756.0166306868196;1819.736138259945;1832.660957722812;1854.1748921729836;1913.8181872722068;58813.41186588122;60770;60833.08750368748;61487.61818100003;62184.378156218314;10127.949360253151;10189.286749927582;10277.869434362214;10319.226058045677;10465.110465610356;13061.21632702041;13090.672733181747;13151.276679782512;13289.93355033238;13312.933435332761;7015.89476157858;7052.471064670171;7181.497374373285;7416.517926334771;7566.394688424913;6477.740890364427;6493.22081350241;6537.803865884031;6703.966480167665;6838.794836154923;4265.53079161292;4275.935860962088;4389.4513185851765;4397.384366188736;4400.515943246241;1663.2515368084169;1690.4928521443517;1758.0594382005565;1764.2149243586737;1863.5154859736567;839.6893149534711;868;891.7681402835309;903.4534106865252;971.3540495570367;14986.775198372034;15329.233538323038;15467.303971321318;15499.845001550066;15745.68508629821;835.4110352201683;838.7357982235699;866.5060915278231;866.843968085738;892.7634176943116;8488.193621605938;8844.380893337533;8855.291576673979;8869.778255543533;8901.109889011048;408373;410487;413754;419098;423243.53512930183;40908;41473.79263103665;42053.78973105115;47277;71355;905.7146998695522;916.408916249029;928.8746019287445;939.6429356844355;940.1115945431638;11608.477618507019;14645.780313295096;14827.629309267355;14982.550523483877;15277.312520936362;33384.33231335408;34152.316953661284;34543.827280863436;35068.82465587656;35144;38784.22431551297;41071.38392924049;42392.788036060854;42422;42871;7214.2064372917885;7243.891341629775;7247.782566523013;7275.454340924346;7346.77959661211;8308.086110527958;10222.591096356062;11147.609833655782;11240.831387529357;11693.88306116928;9434.103760142776;9451.810963780823;9741.80516389654;9782.461964591732;10173.440460774433;9710.514474276117;9859.260555458513;9910.702678919355;10023.899761002589;10104.393736375841;9893.703188904057;9927.602895884083;10064.54709538058;10088.192944564564;10143.594256229668;7174.354308112295;7428.2571742825285;7500.437467190091;7553.509021913558;7644.15914249421;9981.700548983543;10088.546015429176;10098.091171794575;10311.278210525192;10406.843897341698 15:43:05 INFO - PROCESS | 3406 | |3;mootools.html;1279.9296038717866;1423.3737155651513;1426.3224968140132;1586.1910425682897;1774.30801987225;7283.562986220831;7483;7485.438592105594;7491.5505069695855;7491.625418729069;7315.743948961787;7462.552246865178;7467.365273951721;7478.588677622729;7481.438892083088;1944.7763507196642;2227.799498045176;2228.554289142174;2261.7851304126084;2273.27255278311;2254.0420321363436;2267.5351552931693;2268.2854900706307;2269.5914735347633;2271.818254539641;2170.305502239284;2233.7542870284256;2238.0823862216494;2238.8656680599215;2239.0931672672596;2149.161826887515;2155.299527653519;2157.805797478227;2218.234709025384;2219.2676416782583;2187.7812218777995;2203.6143674856994;2209.2157284164214;2212.037763572851;2224.877631730254;7531.774046778605;7587;7590.734324298623;7592.430567707389;7600.1639819619795;4532.773361331921;4623.83816566422;4628;4649.209634362167;4664.277037059262;3048.725614694688;3050.679678633756;3112.3152906360565;3120.9063728088195;3200.8879689210767;913.324140136301;915.6062892956027;919.214071968464;920.581135583308;959.5346257065318;10059.949700251453;10164.898351016544;10187.847182292271;10245;10253.43606101664;3973.2252210818615;4066.674666026711;4134.235166494208;4141.337386018223;4250.511191212988;8318.792030199173;8360.790980225544;8368.121347258571;8372.623231954576;8376.162383761575;3996.980015099906;4587.105514424655;4616.284475906173;4651.511591282867;4652.581267685857;4040.1717647882115;4123.97938010314;4177.958220417818;4230.936535951963;4236.2586547354085;3626.3472574936764;3697.22358304759;3725.6460636239512;3741.0460332615007;3782.7541209821275;1169.8830116988404;1177.2936238256978;1179.9351035693119;1180.3626041937257;1189.5122999570308;1216.0697066743949;1227.374039239994;1233.2230694662305;1233.8457692788402;1253.310679126495;7201.531900426456;7271.091113610799;7296.854062918712;7340.229275925951;7344.30229128232;459.0955817040425;465.7578059409156;469.26794201046476;469.6313393985705;474.7673639916485;5534.308211473566;5616.494515493625;5618.522425593788;5633.718314084279;5670.5463562914865;9084.40951338174;9182.724518264462;9391.248700104112;9404.576794044284;9583.466645336714;9180.081991800767;9190.58642361082;9279.443233406017;9358.298127640453;9498;7029.61337126463;7191.137063552407;7238.059052323164;7240;7296.16094149169;6865.450763938773;6879.277675844164;6901.896471553031;6906.8618627626165;6940.7917762467205;8303.252707256375;8338.583070846313;8360.958195208985;8446.043884640327;8546.145385461405;8698.91301086981;8729.607167677597;8844.159804818531;8852.468851868909;8888.0667529911;5911.231539899957;6436.324185960407;6517.3808488193545;6610.338966103352;6679.599224046573;7257.165425976081;7286.672099755418;7298.2701729826595;7322.121345438582;7329.303716146957;6366.522510811615;6509.283978762427;6534.150560427114;6566.507511936528;6587.63767992765;6313.873722525615;6351.555391122577;6365.745370185326;6374;6394.680265986775;6774.390304872585;6833.2483426824;6839.521233513805;6943.618101004493;6979.057827193467;6144.754209831557;6352.364763523796;6355.1420558224045;6431.260405053479;6483.189601299838;6328.303886572381;6382.808515744535;6391.744330226925;6397.520185985976;6405.8718825624155 15:43:05 INFO - PROCESS | 3406 | |4;prototype.html;314.6318806995815;316.8463295301778;318.28068565043003;328.8750274895542;330.79490715756236;5443.891122177559;5476.17857321402;5502.5873059520545;5529.806456774014;5573.777048918048;5420;5493.807716729915;5503.862403439916;5511.476409741068;5512.173174023898;4028.8589899353383;4143.316352801784;4237.046664500478;4272.700910936236;4284.443022407083;4263.339182426729;4264.317709166534;4276.743395396271;4280.935785963213;4293.098449325646;4224.218519573873;4228.492580890297;4230.76730779807;4235.449391579105;4241.257779888522;4001.2197621463824;4153.397757325201;4243.363495475673;4247.065645557972;4271.594198551133;3752.1745216052423;3755.061234691327;3757.1170774867883;3758.966284271847;3765.4540091686827;5225.817096401608;5242.9213561796605;5251.422343542207;5254.605904557174;5258.92111618326;4933.432655244657;4941.110600091982;4944.134776414113;4946.87632809179;4950.257461380786;5792.913106303409;5794.391588883149;5799.130130480419;5804;5811.070228763419;3887.222555488885;4144.109016561454;4151.4395556599775;4153.06556024895;4159.688023398257;5969.224000879901;6089.939100609025;6103.9928411812;6126.356732543063;6153.692315384213;4100.610442008005;4101.2207680540605;4101.589841015934;4103.466549348625;4103.815328310233;4152.065785198306;4154.376843473503;4154.8338066477;4158.459400278005;4163.500379954425;4807.567318941242;4810.518948105161;4811.08589368019;4817.397825271841;4825.1555977703765;5842.649441033466;5849.64902105875;5859.091840764689;5860.355360910382;5862.824115276549;1412.4703236286393;1435.6913263648157;1470.6985068061235;1482.0959214878915;1485.8959872809016;893.3924931046951;955.8375076237056;974.741693451236;981.4160574458186;985.0838719990478;4935.259711043373;4935.3090567320605;4957.950420495749;4965.776540055706;4977.925331120036;5909.674967876808;5911.615744976562;5969.791057312973;5981.491573216238;5984.311804142492;4961.231009193581;4966.850994470172;4971.1797553403285;4971.701697898137;4973.701577905337;3179.030395729325;3221.8066915985114;3222.8066316020645;3223.6453990061073;3224.8710051597673;5575.972120139373;5582.385937546866;5586.55307575393;5586.692731899784;5589.74846131925;6046.909296360558;6269.905951410732;6273.247210334789;6289.339619339903;6297;5665.971670141623;5689.829305120853;5700.657960522382;5703.572232082527;5708.143778433268;6109.84725381869;6110.938890611037;6112.235970503687;6112.32764395925;6119.357467465852;5983.611065280743;5999.5500337473995;6000.849978750566;6003.849903752441;6004.609700369462;5523.1991361253195;5674.290713660793;5689.886202276014;5698.715064246854;5701.543876489954;4053.2298863215897;4060.5127384714024;4083.428320035138;4084.4281800548542;4085.632293093517;6013;6013.609115407485;6021.909671354845;6023.698815059317;6029.728662210299;5819.534437244925;5824.912626310524;5835.153902684002;5835.241418615553;5841.094630332305;5704.11586204139;5737.655740655574;5741.712914354182;5825.50483208932;5835.67903765297;5480.780768769205;5606.495415412633;5650.604457687922;5654.755953690182;5658;5776.797812076557;5786.247787787561;5792.1311803229855;5823.912641310299;5824.650520968756;5705.258316418839;5712.885742285214;5713.885722285448;5723.8569035774435;5724.055530837365 15:43:05 INFO - PROCESS | 3406 | |5;yui.html;705.2630001648278;729.9634518983042;767.3209209849283;777.9144294127645;783.8393129408472;11764.529418823247;11942.64172074837;11962.82055769163;11968.7606247875;11993.460294286757;11764.470598823053;11797.469113889874;11804.940975295112;11827.40862956853;12638.684032899182;796.3151689547;811.4036183405193;812.155358427235;812.175641723651;812.2567850416862;785.140271402813;795.916428774979;796.4464697035562;796.6136423834436;796.956167410795;837.2757564706516;838.2623291503469;843.2284459719349;843.5065486690294;844.1558441558442;829.983400331996;830.6054624053587;830.6967956695823;832.500499700175;833.529056083314;618.6071844378807;619.3465893482374;620.1411045701735;620.5283984172016;621.037392042337;12309.322987235788;12536.623901282976;12576.559820406334;12606.558770443082;12607.11750177488;12266.26402415858;12605.432755525931;12615.621531354074;12705.936470317682;12893.613191604172;9745.31782775206;9875.90124098757;9916.652917147865;9917.603295868157;9944.701658950244;3289.473684210539;3337.4660054391425;3350.5979282486014;3400.370931377703;3450.6894379505966;38123;38586.421203681966;38734.225315493815;41211.7939410304;43587.3461898075;9286.257099432029;9535.666251681158;9536.475493847765;9719.708408747749;9957.153641940371;16936.40722574704;16973.236204370834;16988.91505542489;17000.829991699924;17026.65946681084;6863.38229559342;6953.687084081229;7049.118860142482;7102.4318054555515;7268.890966635505;3846.8653597123966;3847.672947799412;3917.05990562263;3941.7043721720984;3967.7024223183375;3039.2098054505545;3060.648025477054;3098.9225269367994;3102.782805203614;3105.4099721052926;555.6638233868451;561.9129034999581;562.5583916625429;566.14794733926;566.623195574938;586.3667239381543;604.7097393251264;612.788587937161;617.6417677746896;634.7619642634012;7714.729984450517;7874.9368835206515;8275.793105172299;8277.751667449986;8285.792855178668;598.2611474828583;625.7027911741886;632.8544434779934;634.614811651486;635.3487675133026;3683.3185860615336;3753.981230093832;3812.4281357796;3845.384738441892;3887.1059656279213;48173.75913120412;49404.752976234886;49833.25250121251;50119.24821127686;51071.48928510742;45853.31220031702;45993.7700311503;46004;46142.5385746145;46608;36776.816115919246;41609.79195104005;41803.372949405784;41876;42452.787736061124;8047.879281810895;8077.071136819106;8155.673773049011;8242.464239824632;8383.874241886499;31221;31287.592058357885;31917.36165276635;31921.201969950936;32074;37084.6291537092;37812.81093594514;39087.80456097701;39386.606133939444;39411.60588394194;9755.951220243853;9852.162566181669;9876.950615246878;9922.801543968935;9981.500924953869;10227.642032528825;10232.948835255776;10521.316114452537;10635.574577017142;10677.305975111592;10162.234121819574;10533.315334503233;10543.89456105429;10669;10808.459577021275;10172;10444.321119127233;10465.058144767008;10632.202584806017;10937.890621093688;10112.342697724624;10283.84574231402;10376.844347334645;10404.947975260378;10431.799537624105;8910.777230569287;9330.580123894306;9404.341696081208;9451.574679139318;9536.666216682383;8849.222931964281;9150.771230719285;9191.586378613112;9198.402103863227;9323.627054917728 15:43:05 INFO - PROCESS | 3406 | __end_tp_report 15:43:05 INFO - PROCESS | 3406 | __start_cc_report 15:43:05 INFO - PROCESS | 3406 | _x_x_mozilla_cycle_collect,873 15:43:05 INFO - PROCESS | 3406 | __end_cc_report 15:43:05 INFO - PROCESS | 3406 | __startTimestamp1458340985510__endTimestamp 15:43:05 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | ------- Summary: start ------- 15:43:05 INFO - PROCESS | 3406 | Number of tests: 6 15:43:05 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | [#0] dojo.html Cycles:165 Average:4655.02 Median:4774.52 stddev:493.59 (10.3%) stddev-sans-first:467.40 15:43:05 INFO - PROCESS | 3406 | Values: 2576.5 2579.3 2588.7 2619.9 2652.5 4575.5 4667.0 4694.0 4695.6 4704.5 4693.6 4734.1 4740.1 4779.4 4861.3 4278.2 4307.7 4308.5 4330.8 4474.6 4245.8 4427.8 4445.7 4450.7 4488.5 4287.3 4312.4 4335.9 4362.8 4408.3 4269.2 4271.6 4285.7 4314.7 4326.8 4182.7 4269.3 4271.2 4286.6 4323.1 4573.3 4603.7 4625.4 4660.0 4670.6 5057.7 5089.4 5089.9 5105.6 5139.9 4919.1 5073.7 5131.4 5134.2 5142.6 4805.2 4813.0 4834.0 4836.1 4859.2 5258.4 5268.1 5270.2 5270.8 5276.8 4906.3 5006.0 5054.9 5091.9 5110.7 5087.9 5094.4 5100.4 5105.0 5140.0 5062.3 5066.7 5072.8 5077.5 5096.2 4857.1 5054.7 5060.8 5091.1 5147.5 4336.7 4351.4 4359.3 4367.7 4409.7 3788.0 3791.6 3809.3 3815.9 3828.8 4276.3 4278.3 4279.0 4286.4 4357.9 4996.0 4997.7 5001.7 5004.5 5043.3 4268.0 4275.1 4278.3 4284.5 4321.7 4421.2 4446.2 4453.9 4472.5 4502.6 4669.6 4683.3 4686.6 4692.8 4729.0 4825.1 4953.1 4967.1 4976.3 5022.9 4719.8 4731.3 4733.4 4761.4 4779.6 4824.7 4857.8 4860.1 4861.9 4905.2 4849.7 4925.9 4945.7 4958.5 4986.9 4869.7 4883.1 4923.1 4937.2 4945.9 4923.3 4940.1 4942.2 4949.5 4983.4 4733.9 4752.9 4865.7 4868.3 4916.5 4867.6 4886.3 4894.7 4940.6 4947.9 4757.4 4758.5 4774.4 4774.5 4810.5 15:43:05 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | [#1] ext.html Cycles:180 Average:44030.32 Median:3360.91 stddev:72967.18 (2171.1%) stddev-sans-first:73098.68 15:43:05 INFO - PROCESS | 3406 | Values: 501.4 534.2 536.5 543.2 558.2 26293.0 26760.6 34096.5 34424.5 34526.0 37332.6 37895.0 37947.6 38024.2 38024.2 7383.7 7617.5 7803.6 7810.9 9588.3 9713.0 9872.2 9874.5 9875.3 9875.7 9793.9 9820.6 9825.6 9831.0 9864.6 9661.1 9740.1 9748.4 9759.7 9838.4 9688.9 10135.7 10145.6 10147.6 10151.1 37248.6 37540.6 37585.8 37615.0 37632.2 3247.3 3287.8 3301.1 3330.8 3365.2 29130.6 29446.0 29881.3 30175.4 30809.4 3308.9 3356.6 3373.5 3384.3 3405.7 184704.0 273508.0 275497.0 275880.0 276214.0 56187.0 57392.0 57560.4 57570.0 57616.7 60997.0 61638.4 61653.0 61729.7 61753.0 12778.6 12888.2 12889.7 12950.8 12978.5 9272.9 10717.8 11082.0 11087.2 11145.7 19148.4 19178.8 19349.3 19393.7 19419.8 7528.7 7722.8 7745.2 7800.5 7906.3 809.3 895.8 908.9 1002.8 1007.8 26260.7 26805.2 27238.0 27300.7 27394.3 982.4 997.7 1024.5 1041.0 1048.5 13734.2 13768.9 14128.0 14270.6 14450.6 290664.0 295309.0 295506.0 296340.0 296688.0 45845.0 46383.8 46390.1 46394.0 46403.5 1123.4 1195.1 1237.6 1238.9 1241.8 23988.5 26225.7 27585.7 27643.8 27716.7 37161.8 43101.6 43993.3 43998.0 44051.8 279100.0 281646.0 283279.0 283371.0 283921.0 34214.3 38948.6 40311.4 40368.6 40980.6 36613.3 36687.8 36730.3 37410.6 37431.0 30430.0 32265.4 32341.7 32456.8 33045.8 32165.0 32566.7 32615.8 32760.5 32774.7 33826.0 34079.3 34182.3 34755.1 35077.6 30452.7 30838.8 30861.2 31201.0 31366.2 24292.5 24406.6 24633.0 24792.8 24883.5 15:43:05 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | [#2] jquery.html Cycles:180 Average:23177.21 Median:4393.42 stddev:67779.94 (1542.8%) stddev-sans-first:67948.40 15:43:05 INFO - PROCESS | 3406 | Values: 349.5 357.1 362.4 362.9 369.2 15516.7 15547.5 16612.7 16682.7 16874.4 15537.1 15742.4 16323.2 16339.4 16342.0 4897.3 5015.2 5021.8 5027.1 5298.6 5206.7 5217.5 5221.3 5242.1 5243.1 5057.6 5211.5 5213.6 5215.5 5217.0 5209.8 5216.5 5239.0 5243.5 5244.4 4946.1 5054.4 5062.1 5065.8 5070.9 12383.1 12630.4 12655.6 12664.1 12687.2 1937.8 1957.1 1965.0 2008.1 2117.9 9083.6 9249.5 9538.0 9546.5 10162.6 1756.0 1819.7 1832.7 1854.2 1913.8 58813.4 60770.0 60833.1 61487.6 62184.4 10127.9 10189.3 10277.9 10319.2 10465.1 13061.2 13090.7 13151.3 13289.9 13312.9 7015.9 7052.5 7181.5 7416.5 7566.4 6477.7 6493.2 6537.8 6704.0 6838.8 4265.5 4275.9 4389.5 4397.4 4400.5 1663.3 1690.5 1758.1 1764.2 1863.5 839.7 868.0 891.8 903.5 971.4 14986.8 15329.2 15467.3 15499.8 15745.7 835.4 838.7 866.5 866.8 892.8 8488.2 8844.4 8855.3 8869.8 8901.1 408373.0 410487.0 413754.0 419098.0 423243.5 40908.0 41473.8 42053.8 47277.0 71355.0 905.7 916.4 928.9 939.6 940.1 11608.5 14645.8 14827.6 14982.6 15277.3 33384.3 34152.3 34543.8 35068.8 35144.0 38784.2 41071.4 42392.8 42422.0 42871.0 7214.2 7243.9 7247.8 7275.5 7346.8 8308.1 10222.6 11147.6 11240.8 11693.9 9434.1 9451.8 9741.8 9782.5 10173.4 9710.5 9859.3 9910.7 10023.9 10104.4 9893.7 9927.6 10064.5 10088.2 10143.6 7174.4 7428.3 7500.4 7553.5 7644.2 9981.7 10088.5 10098.1 10311.3 10406.8 15:43:05 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | [#3] mootools.html Cycles:180 Average:5295.61 Median:6353.75 stddev:2767.14 (43.6%) stddev-sans-first:2758.44 15:43:05 INFO - PROCESS | 3406 | Values: 1279.9 1423.4 1426.3 1586.2 1774.3 7283.6 7483.0 7485.4 7491.6 7491.6 7315.7 7462.6 7467.4 7478.6 7481.4 1944.8 2227.8 2228.6 2261.8 2273.3 2254.0 2267.5 2268.3 2269.6 2271.8 2170.3 2233.8 2238.1 2238.9 2239.1 2149.2 2155.3 2157.8 2218.2 2219.3 2187.8 2203.6 2209.2 2212.0 2224.9 7531.8 7587.0 7590.7 7592.4 7600.2 4532.8 4623.8 4628.0 4649.2 4664.3 3048.7 3050.7 3112.3 3120.9 3200.9 913.3 915.6 919.2 920.6 959.5 10059.9 10164.9 10187.8 10245.0 10253.4 3973.2 4066.7 4134.2 4141.3 4250.5 8318.8 8360.8 8368.1 8372.6 8376.2 3997.0 4587.1 4616.3 4651.5 4652.6 4040.2 4124.0 4178.0 4230.9 4236.3 3626.3 3697.2 3725.6 3741.0 3782.8 1169.9 1177.3 1179.9 1180.4 1189.5 1216.1 1227.4 1233.2 1233.8 1253.3 7201.5 7271.1 7296.9 7340.2 7344.3 459.1 465.8 469.3 469.6 474.8 5534.3 5616.5 5618.5 5633.7 5670.5 9084.4 9182.7 9391.2 9404.6 9583.5 9180.1 9190.6 9279.4 9358.3 9498.0 7029.6 7191.1 7238.1 7240.0 7296.2 6865.5 6879.3 6901.9 6906.9 6940.8 8303.3 8338.6 8361.0 8446.0 8546.1 8698.9 8729.6 8844.2 8852.5 8888.1 5911.2 6436.3 6517.4 6610.3 6679.6 7257.2 7286.7 7298.3 7322.1 7329.3 6366.5 6509.3 6534.2 6566.5 6587.6 6313.9 6351.6 6365.7 6374.0 6394.7 6774.4 6833.2 6839.5 6943.6 6979.1 6144.8 6352.4 6355.1 6431.3 6483.2 6328.3 6382.8 6391.7 6397.5 6405.9 15:43:05 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | [#4] prototype.html Cycles:180 Average:4796.42 Median:5503.22 stddev:1424.23 (25.9%) stddev-sans-first:1387.93 15:43:05 INFO - PROCESS | 3406 | Values: 314.6 316.8 318.3 328.9 330.8 5443.9 5476.2 5502.6 5529.8 5573.8 5420.0 5493.8 5503.9 5511.5 5512.2 4028.9 4143.3 4237.0 4272.7 4284.4 4263.3 4264.3 4276.7 4280.9 4293.1 4224.2 4228.5 4230.8 4235.4 4241.3 4001.2 4153.4 4243.4 4247.1 4271.6 3752.2 3755.1 3757.1 3759.0 3765.5 5225.8 5242.9 5251.4 5254.6 5258.9 4933.4 4941.1 4944.1 4946.9 4950.3 5792.9 5794.4 5799.1 5804.0 5811.1 3887.2 4144.1 4151.4 4153.1 4159.7 5969.2 6089.9 6104.0 6126.4 6153.7 4100.6 4101.2 4101.6 4103.5 4103.8 4152.1 4154.4 4154.8 4158.5 4163.5 4807.6 4810.5 4811.1 4817.4 4825.2 5842.6 5849.6 5859.1 5860.4 5862.8 1412.5 1435.7 1470.7 1482.1 1485.9 893.4 955.8 974.7 981.4 985.1 4935.3 4935.3 4958.0 4965.8 4977.9 5909.7 5911.6 5969.8 5981.5 5984.3 4961.2 4966.9 4971.2 4971.7 4973.7 3179.0 3221.8 3222.8 3223.6 3224.9 5576.0 5582.4 5586.6 5586.7 5589.7 6046.9 6269.9 6273.2 6289.3 6297.0 5666.0 5689.8 5700.7 5703.6 5708.1 6109.8 6110.9 6112.2 6112.3 6119.4 5983.6 5999.6 6000.8 6003.8 6004.6 5523.2 5674.3 5689.9 5698.7 5701.5 4053.2 4060.5 4083.4 4084.4 4085.6 6013.0 6013.6 6021.9 6023.7 6029.7 5819.5 5824.9 5835.2 5835.2 5841.1 5704.1 5737.7 5741.7 5825.5 5835.7 5480.8 5606.5 5650.6 5654.8 5658.0 5776.8 5786.2 5792.1 5823.9 5824.7 5705.3 5712.9 5713.9 5723.9 5724.1 15:43:05 INFO - PROCESS | 3406 | 15:43:05 INFO - PROCESS | 3406 | [#5] yui.html Cycles:180 Average:12407.12 Median:48789.26 stddev:13842.16 (28.4%) stddev-sans-first:13853.10 15:43:05 INFO - PROCESS | 3406 | Values: 705.3 730.0 767.3 777.9 783.8 11764.5 11942.6 11962.8 11968.8 11993.5 11764.5 11797.5 11804.9 11827.4 12638.7 796.3 811.4 812.2 812.2 812.3 785.1 795.9 796.4 796.6 797.0 837.3 838.3 843.2 843.5 844.2 830.0 830.6 830.7 832.5 833.5 618.6 619.3 620.1 620.5 621.0 12309.3 12536.6 12576.6 12606.6 12607.1 12266.3 12605.4 12615.6 12705.9 12893.6 9745.3 9875.9 9916.7 9917.6 9944.7 3289.5 3337.5 3350.6 3400.4 3450.7 38123.0 38586.4 38734.2 41211.8 43587.3 9286.3 9535.7 9536.5 9719.7 9957.2 16936.4 16973.2 16988.9 17000.8 17026.7 6863.4 6953.7 7049.1 7102.4 7268.9 3846.9 3847.7 3917.1 3941.7 3967.7 3039.2 3060.6 3098.9 3102.8 3105.4 555.7 561.9 562.6 566.1 566.6 586.4 604.7 612.8 617.6 634.8 7714.7 7874.9 8275.8 8277.8 8285.8 598.3 625.7 632.9 634.6 635.3 3683.3 3754.0 3812.4 3845.4 3887.1 48173.8 49404.8 49833.3 50119.2 51071.5 45853.3 45993.8 46004.0 46142.5 46608.0 36776.8 41609.8 41803.4 41876.0 42452.8 8047.9 8077.1 8155.7 8242.5 8383.9 31221.0 31287.6 31917.4 31921.2 32074.0 37084.6 37812.8 39087.8 39386.6 39411.6 9756.0 9852.2 9877.0 9922.8 9981.5 10227.6 10232.9 10521.3 10635.6 10677.3 10162.2 10533.3 10543.9 10669.0 10808.5 10172.0 10444.3 10465.1 10632.2 10937.9 10112.3 10283.8 10376.8 10404.9 10431.8 8910.8 9330.6 9404.3 9451.6 9536.7 8849.2 9150.8 9191.6 9198.4 9323.6 15:43:05 INFO - PROCESS | 3406 | -------- Summary: end -------- 15:43:05 INFO - PROCESS | 3406 | 15:43:06 INFO - TEST-INFO | 3406: exit 0 15:43:06 INFO - TEST-OK | dromaeo_css | took 1122525ms 15:43:06 INFO - TEST-START | kraken 15:43:06 INFO - operating with platform_type : linux_ 15:43:06 INFO - Initialising browser for kraken test... 15:43:06 INFO - TEST-INFO | started process 3582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvDQg4h/profile http://localhost:50570/getInfo.html) 15:43:10 INFO - PROCESS | 3582 | __metrics Screen width/height:1600/1200 15:43:10 INFO - PROCESS | 3582 | colorDepth:24 15:43:10 INFO - PROCESS | 3582 | Browser inner width/height: 1024/697 15:43:10 INFO - PROCESS | 3582 | __metrics 15:43:11 ERROR - PROCESS | 3582 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:43:11 INFO - PROCESS | 3582 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 15:43:12 INFO - TEST-INFO | 3582: exit 0 15:43:12 INFO - Browser initialized. 15:43:12 INFO - Running cycle 1/1 for kraken test... 15:43:12 INFO - TEST-INFO | started process 3664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvDQg4h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:24 INFO - PROCESS | 3664 | RSS: Main: 154927104 15:43:24 INFO - PROCESS | 3664 | 15:43:27 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50570/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:27 INFO - PROCESS | 3664 | RSS: Main: 197345280 15:43:27 INFO - PROCESS | 3664 | 15:43:30 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50570/tests/kraken/driver.html?testName=audio-dft) 15:43:31 INFO - PROCESS | 3664 | RSS: Main: 186900480 15:43:31 INFO - PROCESS | 3664 | 15:43:34 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50570/tests/kraken/driver.html?testName=audio-fft) 15:43:34 INFO - PROCESS | 3664 | RSS: Main: 173142016 15:43:34 INFO - PROCESS | 3664 | 15:43:36 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50570/tests/kraken/driver.html?testName=audio-oscillator) 15:43:37 INFO - PROCESS | 3664 | RSS: Main: 174628864 15:43:37 INFO - PROCESS | 3664 | 15:43:39 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50570/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:40 INFO - PROCESS | 3664 | RSS: Main: 175235072 15:43:40 INFO - PROCESS | 3664 | 15:43:43 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50570/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:43 INFO - PROCESS | 3664 | RSS: Main: 176431104 15:43:43 INFO - PROCESS | 3664 | 15:43:47 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50570/tests/kraken/driver.html?testName=imaging-desaturate) 15:43:47 INFO - PROCESS | 3664 | RSS: Main: 176164864 15:43:47 INFO - PROCESS | 3664 | 15:43:50 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50570/tests/kraken/driver.html?testName=json-parse-financial) 15:43:51 INFO - PROCESS | 3664 | RSS: Main: 176513024 15:43:51 INFO - PROCESS | 3664 | 15:43:53 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50570/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:43:53 INFO - PROCESS | 3664 | RSS: Main: 187379712 15:43:53 INFO - PROCESS | 3664 | 15:43:55 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:43:56 INFO - PROCESS | 3664 | RSS: Main: 183767040 15:43:56 INFO - PROCESS | 3664 | 15:43:58 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:43:58 INFO - PROCESS | 3664 | RSS: Main: 191201280 15:43:58 INFO - PROCESS | 3664 | 15:44:01 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:01 INFO - PROCESS | 3664 | RSS: Main: 200802304 15:44:01 INFO - PROCESS | 3664 | 15:44:04 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:05 INFO - PROCESS | 3664 | RSS: Main: 199819264 15:44:05 INFO - PROCESS | 3664 | 15:44:06 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:50570/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50570/tests/kraken/driver.html?testName=ai-astar) 15:44:07 INFO - PROCESS | 3664 | RSS: Main: 260153344 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | __start_tp_report 15:44:07 INFO - PROCESS | 3664 | _x_x_mozilla_page_load 15:44:07 INFO - PROCESS | 3664 | _x_x_mozilla_page_load_details 15:44:07 INFO - PROCESS | 3664 | |i|pagename|runs| 15:44:07 INFO - PROCESS | 3664 | |0;ai-astar;110;111;107;110;111;114;100;111;111;111 15:44:07 INFO - PROCESS | 3664 | |1;audio-beat-detection;163;129;162;176;134;162;151;130;171;137 15:44:07 INFO - PROCESS | 3664 | |2;audio-dft;162;162;163;162;161;161;164;163;162;162 15:44:07 INFO - PROCESS | 3664 | |3;audio-fft;76;73;106;96;74;73;73;120;96;74 15:44:07 INFO - PROCESS | 3664 | |4;audio-oscillator;94;93;140;93;93;93;136;94;93;134 15:44:07 INFO - PROCESS | 3664 | |5;imaging-gaussian-blur;116;117;116;117;116;116;117;117;117;117 15:44:07 INFO - PROCESS | 3664 | |6;imaging-darkroom;147;147;146;146;146;146;146;147;147;146 15:44:07 INFO - PROCESS | 3664 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 15:44:07 INFO - PROCESS | 3664 | |8;json-parse-financial;66;67;66;67;66;67;66;75;64;64 15:44:07 INFO - PROCESS | 3664 | |9;json-stringify-tinderbox;64;64;64;65;63;64;64;64;64;65 15:44:07 INFO - PROCESS | 3664 | |10;stanford-crypto-aes;80;82;82;83;83;82;80;80;81;83 15:44:07 INFO - PROCESS | 3664 | |11;stanford-crypto-ccm;115;113;115;117;125;118;121;119;123;115 15:44:07 INFO - PROCESS | 3664 | |12;stanford-crypto-pbkdf2;139;129;138;131;137;127;136;137;137;155 15:44:07 INFO - PROCESS | 3664 | |13;stanford-crypto-sha256-iterative;66;67;68;67;66;65;66;67;68;66 15:44:07 INFO - PROCESS | 3664 | __end_tp_report 15:44:07 INFO - PROCESS | 3664 | __start_cc_report 15:44:07 INFO - PROCESS | 3664 | _x_x_mozilla_cycle_collect,1125 15:44:07 INFO - PROCESS | 3664 | __end_cc_report 15:44:07 INFO - PROCESS | 3664 | __startTimestamp1458341047009__endTimestamp 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | ------- Summary: start ------- 15:44:07 INFO - PROCESS | 3664 | Number of tests: 14 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:4.00 15:44:07 INFO - PROCESS | 3664 | Values: 110.0 111.0 107.0 110.0 111.0 114.0 100.0 111.0 111.0 111.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:162.00 stddev:17.70 (10.9%) stddev-sans-first:18.27 15:44:07 INFO - PROCESS | 3664 | Values: 163.0 129.0 162.0 176.0 134.0 162.0 151.0 130.0 171.0 137.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 15:44:07 INFO - PROCESS | 3664 | Values: 162.0 162.0 163.0 162.0 161.0 161.0 164.0 163.0 162.0 162.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.00 stddev:17.16 (23.2%) stddev-sans-first:17.81 15:44:07 INFO - PROCESS | 3664 | Values: 76.0 73.0 106.0 96.0 74.0 73.0 73.0 120.0 96.0 74.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#4] audio-oscillator Cycles:10 Average:106.30 Median:93.00 stddev:21.01 (22.6%) stddev-sans-first:21.81 15:44:07 INFO - PROCESS | 3664 | Values: 94.0 93.0 140.0 93.0 93.0 93.0 136.0 94.0 93.0 134.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:44:07 INFO - PROCESS | 3664 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:44:07 INFO - PROCESS | 3664 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:44:07 INFO - PROCESS | 3664 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:66.50 stddev:3.08 (4.6%) stddev-sans-first:3.26 15:44:07 INFO - PROCESS | 3664 | Values: 66.0 67.0 66.0 67.0 66.0 67.0 66.0 75.0 64.0 64.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 15:44:07 INFO - PROCESS | 3664 | Values: 64.0 64.0 64.0 65.0 63.0 64.0 64.0 64.0 64.0 65.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 15:44:07 INFO - PROCESS | 3664 | Values: 80.0 82.0 82.0 83.0 83.0 82.0 80.0 80.0 81.0 83.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:118.50 stddev:3.90 (3.3%) stddev-sans-first:3.97 15:44:07 INFO - PROCESS | 3664 | Values: 115.0 113.0 115.0 117.0 125.0 118.0 121.0 119.0 123.0 115.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:137.00 stddev:7.66 (5.6%) stddev-sans-first:8.08 15:44:07 INFO - PROCESS | 3664 | Values: 139.0 129.0 138.0 131.0 137.0 127.0 136.0 137.0 137.0 155.0 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - PROCESS | 3664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 15:44:07 INFO - PROCESS | 3664 | Values: 66.0 67.0 68.0 67.0 66.0 65.0 66.0 67.0 68.0 66.0 15:44:07 INFO - PROCESS | 3664 | -------- Summary: end -------- 15:44:07 INFO - PROCESS | 3664 | 15:44:07 INFO - TEST-INFO | 3664: exit 0 15:44:08 INFO - TEST-OK | kraken | took 61762ms 15:44:08 INFO - SUITE-END | took 1184s 15:44:08 INFO - Completed test suite (00:19:44) 15:44:08 INFO - javascript benchmark 15:44:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2576.5491039068156, 2579.2906950588585, 2588.7022992355874, 2619.869006549672, 2652.46950609878, 4575.4509458864895, 4667.043256132493, 4694.0, 4695.6478264130155, 4704.529547045298, 4693.577578017977, 4734.1241870254025, 4740.099381117585, 4779.378680771503, 4861.319415281854, 4278.187144442553, 4307.698461107724, 4308.482982042159, 4330.84842030529, 4474.574915383034, 4245.787710614457, 4427.756473393962, 4445.711028783135, 4450.666200034994, 4488.528704486031, 4287.335463003224, 4312.417823593806, 4335.869923902288, 4362.781860906942, 4408.272635015219, 4269.167512335096, 4271.61555460007, 4285.742855428684, 4314.654827613784, 4326.762028088454, 4182.686298527623, 4269.252880745857, 4271.231178387889, 4286.61420472159, 4323.0705398339505, 4573.314002899559, 4603.677742558022, 4625.352450656911, 4660.04469083837, 4670.6497012724185, 5057.671251368649, 5089.3638295213095, 5089.949100508985, 5105.617078719074, 5139.871503212412, 4919.1391506486225, 5073.7209453480045, 5131.435542090405, 5134.229865520165, 5142.588592912558, 4805.1590971579835, 4812.975935120302, 4834.009028149221, 4836.129496690559, 4859.198232291667, 5258.368995720538, 5268.051750684914, 5270.235815806686, 5270.78916843322, 5276.762545685453, 4906.31311616374, 5006.048850718352, 5054.873628159252, 5091.9236211456855, 5110.693358398508, 5087.923681144785, 5094.414142373675, 5100.387953445536, 5105.0, 5140.0, 5062.341895553628, 5066.695998240118, 5072.847814565569, 5077.492250774893, 5096.184610462308, 4857.101436234238, 5054.721990290569, 5060.822871199491, 5091.0581542414775, 5147.485251474897, 4336.739795612273, 4351.43431353922, 4359.324304732771, 4367.650587952956, 4409.735415874994, 3787.981060094682, 3791.6208379162413, 3809.2571948470336, 3815.8664446744788, 3828.8277027533827, 4276.273033584298, 4278.336857787048, 4278.978605107017, 4286.37847512109, 4357.869263922087, 4996.0, 4997.725125118153, 5001.72490513018, 5004.4995500450395, 5043.344365232496, 4267.957320426818, 4275.0594869128745, 4278.294081476583, 4284.507281662586, 4321.740695558214, 4421.204183246982, 4446.244138496463, 4453.933191002137, 4472.530384309665, 4502.594766471033, 4669.626429885601, 4683.344331793483, 4686.554777296152, 4692.788824502837, 4728.95962888164, 4825.131476334153, 4953.133201689618, 4967.05625931072, 4976.32819569368, 5022.924656130234, 4719.811207551659, 4731.313959475926, 4733.408323959505, 4761.357216775829, 4779.641526885567, 4824.6863953842885, 4857.757112144308, 4860.1008813369635, 4861.927071094007, 4905.23968784839, 4849.733264670477, 4925.9014819704125, 4945.727984960718, 4958.504149585013, 4986.853023804472, 4869.70781753096, 4883.096627123993, 4923.08922849274, 4937.21004639256, 4945.851624451272, 4923.261510773269, 4940.086084074458, 4942.233953737176, 4949.455559888482, 4983.377077865267, 4733.857984260478, 4752.904941901212, 4865.70805751656, 4868.294097355934, 4916.508349165055, 4867.63492738039, 4886.340344053508, 4894.730789806595, 4940.555350018516, 4947.925781113358, 4757.429108506863, 4758.452777930583, 4774.40319960005, 4774.522547745198, 4810.518948105161], "unit": "score", "name": "dojo.html", "value": 4623.129598180917}, {"lowerIsBetter": false, "replicates": [501.43087595579004, 534.2493796216316, 536.4769349883861, 543.2259030880994, 558.2129197831058, 26293.0, 26760.59154676079, 34096.4885526717, 34424.48363274553, 34526.0, 37332.626673733255, 37895.0, 37947.62052379475, 38024.23951520968, 38024.239515209745, 7383.6677349519405, 7617.504862183968, 7803.648835802403, 7810.921890781076, 9588.328816982814, 9712.951435242814, 9872.210223182165, 9874.456904870229, 9875.308728389016, 9875.654352097677, 9793.853092203623, 9820.558074886647, 9825.557849896735, 9831.0, 9864.556094975744, 9661.082197191256, 9740.074692904163, 9748.415095094317, 9759.65841195562, 9838.360506567122, 9688.903110968871, 10135.695929122137, 10145.594176232942, 10147.64483243083, 10151.086402223762, 37248.62751372479, 37540.62459375426, 37585.81207093947, 37615.0, 37632.24735505302, 3247.318063206729, 3287.819169945652, 3301.092199645093, 3330.7668463207583, 3365.2259980204444, 29130.563041554393, 29446.0, 29881.25296867574, 30175.396492070256, 30809.383812323853, 3308.9007329780147, 3356.597208334991, 3373.477111047767, 3384.3231353729107, 3405.676460736226, 184704.0, 273508.0, 275497.0, 275880.0, 276214.0, 56187.0, 57392.0, 57560.42439575551, 57570.0, 57616.71191644015, 60997.0, 61638.38361616416, 61653.0, 61729.691351542955, 61753.0, 12778.61664150077, 12888.162269452456, 12889.677758056123, 12950.805737913939, 12978.545750898673, 9272.907270927339, 10717.83923241152, 11082.0, 11087.168462365355, 11145.665630031112, 19148.425547233604, 19178.80821191798, 19349.322773702854, 19393.709094363596, 19419.8058019418, 7528.736494222676, 7722.806929826799, 7745.22547745221, 7800.45396822217, 7906.288434040964, 809.283783851284, 895.8432274351962, 908.8773015642936, 1002.8295189817749, 1007.8034783217203, 26260.73739262621, 26805.195844124708, 27238.0, 27300.72699272982, 27394.315142121606, 982.4498280962683, 997.7006897930592, 1024.4979959819634, 1040.95836166554, 1048.5438834107188, 13734.175949442866, 13768.931155344158, 14128.0, 14270.643233919027, 14450.566483005527, 290664.0, 295309.0, 295506.0, 296340.0, 296688.0, 45845.0, 46383.76808115938, 46390.07219855652, 46394.0, 46403.5359646406, 1123.4045955643521, 1195.0618764270007, 1237.616338934933, 1238.851337839465, 1241.838560987084, 23988.51967346609, 26225.737742623092, 27585.724142758314, 27643.756030979057, 27716.722832771415, 37161.814190928875, 43101.56898430976, 43993.34009989789, 43998.0, 44051.77974110237, 279100.0, 281646.0, 283279.0, 283371.0, 283921.0, 34214.31571368608, 38948.6105138945, 40311.3953290695, 40368.596314036484, 40980.59019409887, 36613.26773464462, 36687.816560918094, 36730.26539469249, 37410.62589374071, 37431.0, 30430.0, 32265.35469290648, 32341.676583234806, 32456.83771581127, 33045.83477082695, 32165.0, 32566.674333256364, 32615.836920815244, 32760.50859237161, 32774.67225327811, 33826.0, 34079.318413632085, 34182.31635367229, 34755.13112172216, 35077.64922350744, 30452.695473044987, 30838.845805770827, 30861.228469288446, 31201.0, 31366.215844604067, 24292.514149716553, 24406.633900491153, 24633.0, 24792.752072479045, 24883.502329953662], "unit": "score", "name": "ext.html", "value": 17694.111605985556}, {"lowerIsBetter": false, "replicates": [349.46880741273264, 357.07517529598334, 362.4327926794567, 362.9437437197234, 369.2338397824513, 15516.689666206668, 15547.533573992785, 16612.66774664506, 16682.66634667306, 16874.409395671155, 15537.14545699986, 15742.449014284502, 16323.183840807971, 16339.428120015802, 16342.0, 4897.289892965527, 5015.197568389059, 5021.799128034874, 5027.145385284511, 5298.576113910878, 5206.687598744069, 5217.478252174771, 5221.347331583552, 5242.135047717122, 5243.10867152585, 5057.620678449131, 5211.5049070338255, 5213.556847667953, 5215.452377500345, 5216.973915130419, 5209.817656382027, 5216.452272511369, 5238.973805130988, 5243.501867322599, 5244.423113457517, 4946.109700253953, 5054.418741844698, 5062.139436295838, 5065.772040258161, 5070.898582028376, 12383.133180677356, 12630.431630576555, 12655.557055503014, 12664.11351205416, 12687.238765674088, 1937.7771556270927, 1957.0508303472805, 1964.9705254421194, 2008.096356639518, 2117.8941052947443, 9083.591238394289, 9249.491277979709, 9537.952310238474, 9546.522673866279, 10162.59349626014, 1756.0166306868196, 1819.736138259945, 1832.660957722812, 1854.1748921729836, 1913.8181872722068, 58813.41186588122, 60770.0, 60833.08750368748, 61487.61818100003, 62184.378156218314, 10127.949360253151, 10189.286749927582, 10277.869434362214, 10319.226058045677, 10465.110465610356, 13061.21632702041, 13090.672733181747, 13151.276679782512, 13289.93355033238, 13312.933435332761, 7015.89476157858, 7052.471064670171, 7181.497374373285, 7416.517926334771, 7566.394688424913, 6477.740890364427, 6493.22081350241, 6537.803865884031, 6703.966480167665, 6838.794836154923, 4265.53079161292, 4275.935860962088, 4389.4513185851765, 4397.384366188736, 4400.515943246241, 1663.2515368084169, 1690.4928521443517, 1758.0594382005565, 1764.2149243586737, 1863.5154859736567, 839.6893149534711, 868.0, 891.7681402835309, 903.4534106865252, 971.3540495570367, 14986.775198372034, 15329.233538323038, 15467.303971321318, 15499.845001550066, 15745.68508629821, 835.4110352201683, 838.7357982235699, 866.5060915278231, 866.843968085738, 892.7634176943116, 8488.193621605938, 8844.380893337533, 8855.291576673979, 8869.778255543533, 8901.109889011048, 408373.0, 410487.0, 413754.0, 419098.0, 423243.53512930183, 40908.0, 41473.79263103665, 42053.78973105115, 47277.0, 71355.0, 905.7146998695522, 916.408916249029, 928.8746019287445, 939.6429356844355, 940.1115945431638, 11608.477618507019, 14645.780313295096, 14827.629309267355, 14982.550523483877, 15277.312520936362, 33384.33231335408, 34152.316953661284, 34543.827280863436, 35068.82465587656, 35144.0, 38784.22431551297, 41071.38392924049, 42392.788036060854, 42422.0, 42871.0, 7214.2064372917885, 7243.891341629775, 7247.782566523013, 7275.454340924346, 7346.77959661211, 8308.086110527958, 10222.591096356062, 11147.609833655782, 11240.831387529357, 11693.88306116928, 9434.103760142776, 9451.810963780823, 9741.80516389654, 9782.461964591732, 10173.440460774433, 9710.514474276117, 9859.260555458513, 9910.702678919355, 10023.899761002589, 10104.393736375841, 9893.703188904057, 9927.602895884083, 10064.54709538058, 10088.192944564564, 10143.594256229668, 7174.354308112295, 7428.2571742825285, 7500.437467190091, 7553.509021913558, 7644.15914249421, 9981.700548983543, 10088.546015429176, 10098.091171794575, 10311.278210525192, 10406.843897341698], "unit": "score", "name": "jquery.html", "value": 7743.103923570334}, {"lowerIsBetter": false, "replicates": [1279.9296038717866, 1423.3737155651513, 1426.3224968140132, 1586.1910425682897, 1774.30801987225, 7283.562986220831, 7483.0, 7485.438592105594, 7491.5505069695855, 7491.625418729069, 7315.743948961787, 7462.552246865178, 7467.365273951721, 7478.588677622729, 7481.438892083088, 1944.7763507196642, 2227.799498045176, 2228.554289142174, 2261.7851304126084, 2273.27255278311, 2254.0420321363436, 2267.5351552931693, 2268.2854900706307, 2269.5914735347633, 2271.818254539641, 2170.305502239284, 2233.7542870284256, 2238.0823862216494, 2238.8656680599215, 2239.0931672672596, 2149.161826887515, 2155.299527653519, 2157.805797478227, 2218.234709025384, 2219.2676416782583, 2187.7812218777995, 2203.6143674856994, 2209.2157284164214, 2212.037763572851, 2224.877631730254, 7531.774046778605, 7587.0, 7590.734324298623, 7592.430567707389, 7600.1639819619795, 4532.773361331921, 4623.83816566422, 4628.0, 4649.209634362167, 4664.277037059262, 3048.725614694688, 3050.679678633756, 3112.3152906360565, 3120.9063728088195, 3200.8879689210767, 913.324140136301, 915.6062892956027, 919.214071968464, 920.581135583308, 959.5346257065318, 10059.949700251453, 10164.898351016544, 10187.847182292271, 10245.0, 10253.43606101664, 3973.2252210818615, 4066.674666026711, 4134.235166494208, 4141.337386018223, 4250.511191212988, 8318.792030199173, 8360.790980225544, 8368.121347258571, 8372.623231954576, 8376.162383761575, 3996.980015099906, 4587.105514424655, 4616.284475906173, 4651.511591282867, 4652.581267685857, 4040.1717647882115, 4123.97938010314, 4177.958220417818, 4230.936535951963, 4236.2586547354085, 3626.3472574936764, 3697.22358304759, 3725.6460636239512, 3741.0460332615007, 3782.7541209821275, 1169.8830116988404, 1177.2936238256978, 1179.9351035693119, 1180.3626041937257, 1189.5122999570308, 1216.0697066743949, 1227.374039239994, 1233.2230694662305, 1233.8457692788402, 1253.310679126495, 7201.531900426456, 7271.091113610799, 7296.854062918712, 7340.229275925951, 7344.30229128232, 459.0955817040425, 465.7578059409156, 469.26794201046476, 469.6313393985705, 474.7673639916485, 5534.308211473566, 5616.494515493625, 5618.522425593788, 5633.718314084279, 5670.5463562914865, 9084.40951338174, 9182.724518264462, 9391.248700104112, 9404.576794044284, 9583.466645336714, 9180.081991800767, 9190.58642361082, 9279.443233406017, 9358.298127640453, 9498.0, 7029.61337126463, 7191.137063552407, 7238.059052323164, 7240.0, 7296.16094149169, 6865.450763938773, 6879.277675844164, 6901.896471553031, 6906.8618627626165, 6940.7917762467205, 8303.252707256375, 8338.583070846313, 8360.958195208985, 8446.043884640327, 8546.145385461405, 8698.91301086981, 8729.607167677597, 8844.159804818531, 8852.468851868909, 8888.0667529911, 5911.231539899957, 6436.324185960407, 6517.3808488193545, 6610.338966103352, 6679.599224046573, 7257.165425976081, 7286.672099755418, 7298.2701729826595, 7322.121345438582, 7329.303716146957, 6366.522510811615, 6509.283978762427, 6534.150560427114, 6566.507511936528, 6587.63767992765, 6313.873722525615, 6351.555391122577, 6365.745370185326, 6374.0, 6394.680265986775, 6774.390304872585, 6833.2483426824, 6839.521233513805, 6943.618101004493, 6979.057827193467, 6144.754209831557, 6352.364763523796, 6355.1420558224045, 6431.260405053479, 6483.189601299838, 6328.303886572381, 6382.808515744535, 6391.744330226925, 6397.520185985976, 6405.8718825624155], "unit": "score", "name": "mootools.html", "value": 4275.875793864928}, {"lowerIsBetter": false, "replicates": [314.6318806995815, 316.8463295301778, 318.28068565043003, 328.8750274895542, 330.79490715756236, 5443.891122177559, 5476.17857321402, 5502.5873059520545, 5529.806456774014, 5573.777048918048, 5420.0, 5493.807716729915, 5503.862403439916, 5511.476409741068, 5512.173174023898, 4028.8589899353383, 4143.316352801784, 4237.046664500478, 4272.700910936236, 4284.443022407083, 4263.339182426729, 4264.317709166534, 4276.743395396271, 4280.935785963213, 4293.098449325646, 4224.218519573873, 4228.492580890297, 4230.76730779807, 4235.449391579105, 4241.257779888522, 4001.2197621463824, 4153.397757325201, 4243.363495475673, 4247.065645557972, 4271.594198551133, 3752.1745216052423, 3755.061234691327, 3757.1170774867883, 3758.966284271847, 3765.4540091686827, 5225.817096401608, 5242.9213561796605, 5251.422343542207, 5254.605904557174, 5258.92111618326, 4933.432655244657, 4941.110600091982, 4944.134776414113, 4946.87632809179, 4950.257461380786, 5792.913106303409, 5794.391588883149, 5799.130130480419, 5804.0, 5811.070228763419, 3887.222555488885, 4144.109016561454, 4151.4395556599775, 4153.06556024895, 4159.688023398257, 5969.224000879901, 6089.939100609025, 6103.9928411812, 6126.356732543063, 6153.692315384213, 4100.610442008005, 4101.2207680540605, 4101.589841015934, 4103.466549348625, 4103.815328310233, 4152.065785198306, 4154.376843473503, 4154.8338066477, 4158.459400278005, 4163.500379954425, 4807.567318941242, 4810.518948105161, 4811.08589368019, 4817.397825271841, 4825.1555977703765, 5842.649441033466, 5849.64902105875, 5859.091840764689, 5860.355360910382, 5862.824115276549, 1412.4703236286393, 1435.6913263648157, 1470.6985068061235, 1482.0959214878915, 1485.8959872809016, 893.3924931046951, 955.8375076237056, 974.741693451236, 981.4160574458186, 985.0838719990478, 4935.259711043373, 4935.3090567320605, 4957.950420495749, 4965.776540055706, 4977.925331120036, 5909.674967876808, 5911.615744976562, 5969.791057312973, 5981.491573216238, 5984.311804142492, 4961.231009193581, 4966.850994470172, 4971.1797553403285, 4971.701697898137, 4973.701577905337, 3179.030395729325, 3221.8066915985114, 3222.8066316020645, 3223.6453990061073, 3224.8710051597673, 5575.972120139373, 5582.385937546866, 5586.55307575393, 5586.692731899784, 5589.74846131925, 6046.909296360558, 6269.905951410732, 6273.247210334789, 6289.339619339903, 6297.0, 5665.971670141623, 5689.829305120853, 5700.657960522382, 5703.572232082527, 5708.143778433268, 6109.84725381869, 6110.938890611037, 6112.235970503687, 6112.32764395925, 6119.357467465852, 5983.611065280743, 5999.5500337473995, 6000.849978750566, 6003.849903752441, 6004.609700369462, 5523.1991361253195, 5674.290713660793, 5689.886202276014, 5698.715064246854, 5701.543876489954, 4053.2298863215897, 4060.5127384714024, 4083.428320035138, 4084.4281800548542, 4085.632293093517, 6013.0, 6013.609115407485, 6021.909671354845, 6023.698815059317, 6029.728662210299, 5819.534437244925, 5824.912626310524, 5835.153902684002, 5835.241418615553, 5841.094630332305, 5704.11586204139, 5737.655740655574, 5741.712914354182, 5825.50483208932, 5835.67903765297, 5480.780768769205, 5606.495415412633, 5650.604457687922, 5654.755953690182, 5658.0, 5776.797812076557, 5786.247787787561, 5792.1311803229855, 5823.912641310299, 5824.650520968756, 5705.258316418839, 5712.885742285214, 5713.885722285448, 5723.8569035774435, 5724.055530837365], "unit": "score", "name": "prototype.html", "value": 4337.403740392315}, {"lowerIsBetter": false, "replicates": [705.2630001648278, 729.9634518983042, 767.3209209849283, 777.9144294127645, 783.8393129408472, 11764.529418823247, 11942.64172074837, 11962.82055769163, 11968.7606247875, 11993.460294286757, 11764.470598823053, 11797.469113889874, 11804.940975295112, 11827.40862956853, 12638.684032899182, 796.3151689547, 811.4036183405193, 812.155358427235, 812.175641723651, 812.2567850416862, 785.140271402813, 795.916428774979, 796.4464697035562, 796.6136423834436, 796.956167410795, 837.2757564706516, 838.2623291503469, 843.2284459719349, 843.5065486690294, 844.1558441558442, 829.983400331996, 830.6054624053587, 830.6967956695823, 832.500499700175, 833.529056083314, 618.6071844378807, 619.3465893482374, 620.1411045701735, 620.5283984172016, 621.037392042337, 12309.322987235788, 12536.623901282976, 12576.559820406334, 12606.558770443082, 12607.11750177488, 12266.26402415858, 12605.432755525931, 12615.621531354074, 12705.936470317682, 12893.613191604172, 9745.31782775206, 9875.90124098757, 9916.652917147865, 9917.603295868157, 9944.701658950244, 3289.473684210539, 3337.4660054391425, 3350.5979282486014, 3400.370931377703, 3450.6894379505966, 38123.0, 38586.421203681966, 38734.225315493815, 41211.7939410304, 43587.3461898075, 9286.257099432029, 9535.666251681158, 9536.475493847765, 9719.708408747749, 9957.153641940371, 16936.40722574704, 16973.236204370834, 16988.91505542489, 17000.829991699924, 17026.65946681084, 6863.38229559342, 6953.687084081229, 7049.118860142482, 7102.4318054555515, 7268.890966635505, 3846.8653597123966, 3847.672947799412, 3917.05990562263, 3941.7043721720984, 3967.7024223183375, 3039.2098054505545, 3060.648025477054, 3098.9225269367994, 3102.782805203614, 3105.4099721052926, 555.6638233868451, 561.9129034999581, 562.5583916625429, 566.14794733926, 566.623195574938, 586.3667239381543, 604.7097393251264, 612.788587937161, 617.6417677746896, 634.7619642634012, 7714.729984450517, 7874.9368835206515, 8275.793105172299, 8277.751667449986, 8285.792855178668, 598.2611474828583, 625.7027911741886, 632.8544434779934, 634.614811651486, 635.3487675133026, 3683.3185860615336, 3753.981230093832, 3812.4281357796, 3845.384738441892, 3887.1059656279213, 48173.75913120412, 49404.752976234886, 49833.25250121251, 50119.24821127686, 51071.48928510742, 45853.31220031702, 45993.7700311503, 46004.0, 46142.5385746145, 46608.0, 36776.816115919246, 41609.79195104005, 41803.372949405784, 41876.0, 42452.787736061124, 8047.879281810895, 8077.071136819106, 8155.673773049011, 8242.464239824632, 8383.874241886499, 31221.0, 31287.592058357885, 31917.36165276635, 31921.201969950936, 32074.0, 37084.6291537092, 37812.81093594514, 39087.80456097701, 39386.606133939444, 39411.60588394194, 9755.951220243853, 9852.162566181669, 9876.950615246878, 9922.801543968935, 9981.500924953869, 10227.642032528825, 10232.948835255776, 10521.316114452537, 10635.574577017142, 10677.305975111592, 10162.234121819574, 10533.315334503233, 10543.89456105429, 10669.0, 10808.459577021275, 10172.0, 10444.321119127233, 10465.058144767008, 10632.202584806017, 10937.890621093688, 10112.342697724624, 10283.84574231402, 10376.844347334645, 10404.947975260378, 10431.799537624105, 8910.777230569287, 9330.580123894306, 9404.341696081208, 9451.574679139318, 9536.666216682383, 8849.222931964281, 9150.771230719285, 9191.586378613112, 9198.402103863227, 9323.627054917728], "unit": "score", "name": "yui.html", "value": 5896.090627569085}], "name": "dromaeo_css", "value": 6408.50976676098}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 110.0, 111.0, 114.0, 100.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [163.0, 129.0, 162.0, 176.0, 134.0, 162.0, 151.0, 130.0, 171.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 161.0, 164.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 106.0, 96.0, 74.0, 73.0, 73.0, 120.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 140.0, 93.0, 93.0, 93.0, 136.0, 94.0, 93.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 75.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.8}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 83.0, 83.0, 82.0, 80.0, 80.0, 81.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [115.0, 113.0, 115.0, 117.0, 125.0, 118.0, 121.0, 119.0, 123.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [139.0, 129.0, 138.0, 131.0, 137.0, 127.0, 136.0, 137.0, 137.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 67.0, 66.0, 65.0, 66.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1507.5999999999995}]} 15:44:08 INFO - Return code: 0 15:44:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:44:08 ERROR - # TBPL SUCCESS # 15:44:08 INFO - Running post-action listener: _resource_record_post_action 15:44:08 INFO - Running post-run listener: _resource_record_post_run 15:44:09 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 10194944; Write bytes: 434212864; Read time: 3036; Write time: 563528 15:44:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15405056; Read time: 0; Write time: 7816 15:44:09 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8458240; Write bytes: 418807808; Read time: 2980; Write time: 555712 15:44:09 INFO - Running post-run listener: _upload_blobber_files 15:44:09 INFO - Blob upload gear active. 15:44:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:09 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 15:44:09 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'] 15:44:09 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 15:44:09 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:44:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:44:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:10 INFO - (blobuploader) - INFO - Done attempting. 15:44:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:44:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:44:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:11 INFO - (blobuploader) - INFO - Done attempting. 15:44:11 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:11 INFO - Return code: 0 15:44:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2434d924ae602bea9ace27af3807b9568ad340ed1beec6085a3ad40dd172f412a960e623f274d195f0a8b3eba8509cb3bb870983baa2e2a584ae214561fa13c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/353ceb5061804c8fe962c8a2a924763fd56e2aabf561c61dfe99a9586ec22c0aeeba8d1f7f690105cee17093eccc399776892d9147b42c71f8dbebb11c5f7245"} 15:44:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:11 INFO - Contents: 15:44:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2434d924ae602bea9ace27af3807b9568ad340ed1beec6085a3ad40dd172f412a960e623f274d195f0a8b3eba8509cb3bb870983baa2e2a584ae214561fa13c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/353ceb5061804c8fe962c8a2a924763fd56e2aabf561c61dfe99a9586ec22c0aeeba8d1f7f690105cee17093eccc399776892d9147b42c71f8dbebb11c5f7245"} 15:44:11 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:11 INFO - Copying logs to upload dir... 15:44:11 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.591162 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-03-18 15:44:11.615872) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 15:44:11.619368) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 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/b2434d924ae602bea9ace27af3807b9568ad340ed1beec6085a3ad40dd172f412a960e623f274d195f0a8b3eba8509cb3bb870983baa2e2a584ae214561fa13c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/353ceb5061804c8fe962c8a2a924763fd56e2aabf561c61dfe99a9586ec22c0aeeba8d1f7f690105cee17093eccc399776892d9147b42c71f8dbebb11c5f7245"} build_url:https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/Xl66dsY-SbmI3Xdmg0UY1Q/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/b2434d924ae602bea9ace27af3807b9568ad340ed1beec6085a3ad40dd172f412a960e623f274d195f0a8b3eba8509cb3bb870983baa2e2a584ae214561fa13c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/353ceb5061804c8fe962c8a2a924763fd56e2aabf561c61dfe99a9586ec22c0aeeba8d1f7f690105cee17093eccc399776892d9147b42c71f8dbebb11c5f7245"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 15:44:11.645632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:44:11.645919) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458339432.930506-663527307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 15:44:11.728639) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 15:44:11.728924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 15:44:11.729398) ========= ========= Total master_lag: 0.30 =========