builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1457564551.0 results: success (0) buildid: 20160309140824 builduid: 0d5f914caa0b400ebc9575dfab15815e revision: 3282a189323c8ea9d2f5ae52e18a2cb4f50873c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.004097) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.004549) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.004839) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004627 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.022456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.022767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.036048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.036490) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004646 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.085540) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.085820) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.086185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.086470) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 15:02:31-- 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% 66.0M=0s 2016-03-09 15:02:31 (66.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093246 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.193971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.194287) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019817 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:31.243556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 15:02:31.243895) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3282a189323c8ea9d2f5ae52e18a2cb4f50873c8 --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 3282a189323c8ea9d2f5ae52e18a2cb4f50873c8 --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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 15:02:31,722 truncating revision to first 12 chars 2016-03-09 15:02:31,722 Setting DEBUG logging. 2016-03-09 15:02:31,722 attempt 1/10 2016-03-09 15:02:31,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3282a189323c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 15:02:33,038 unpacking tar archive at: fx-team-3282a189323c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.622987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 15:02:32.880143) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:32.880547) ========= echo 3282a189323c8ea9d2f5ae52e18a2cb4f50873c8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3282a189323c8ea9d2f5ae52e18a2cb4f50873c8'] 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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3282a189323c8ea9d2f5ae52e18a2cb4f50873c8 program finished with exit code 0 elapsedTime=0.004511 script_repo_revision: '3282a189323c8ea9d2f5ae52e18a2cb4f50873c8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:32.930092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:32.930439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 15:02:32.940412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-09 15:02:32.940726) ========= /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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:02:33 INFO - MultiFileLogger online at 20160309 15:02:33 in /builds/slave/test 15:02:33 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:02:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:02:33 INFO - {'append_to_log': False, 15:02:33 INFO - 'base_work_dir': '/builds/slave/test', 15:02:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:02:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:02:33 INFO - 'branch': 'Fx-Team-Non-PGO', 15:02:33 INFO - 'buildbot_json_path': 'buildprops.json', 15:02:33 INFO - 'config_files': ('talos/linux_config.py',), 15:02:33 INFO - 'default_actions': ('clobber', 15:02:33 INFO - 'read-buildbot-config', 15:02:33 INFO - 'download-and-extract', 15:02:33 INFO - 'populate-webroot', 15:02:33 INFO - 'create-virtualenv', 15:02:33 INFO - 'install', 15:02:33 INFO - 'run-tests'), 15:02:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:02:33 INFO - 'download_minidump_stackwalk': True, 15:02:33 INFO - 'download_symbols': 'ondemand', 15:02:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:02:33 INFO - 'tooltool.py': '/tools/tooltool.py', 15:02:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:02:33 INFO - '/tools/misc-python/virtualenv.py')}, 15:02:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:02:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:02:33 INFO - 'installer_path': 'installer.exe', 15:02:33 INFO - 'log_level': 'info', 15:02:33 INFO - 'log_name': 'talos', 15:02:33 INFO - 'log_to_console': True, 15:02:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:02:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:02:33 INFO - 'opt_config_files': (), 15:02:33 INFO - 'pip_index': False, 15:02:33 INFO - 'sps_profile': False, 15:02:33 INFO - 'sps_profile_interval': 0, 15:02:33 INFO - 'suite': 'dromaeojs', 15:02:33 INFO - 'system_bits': '32', 15:02:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:02:33 INFO - 'title': 'talos-linux64-ix-049', 15:02:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:02:33 INFO - 'use_talos_json': True, 15:02:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:02:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:02:33 INFO - 'work_dir': 'build'} 15:02:33 INFO - ##### 15:02:33 INFO - ##### Running clobber step. 15:02:33 INFO - ##### 15:02:33 INFO - Running pre-action listener: _resource_record_pre_action 15:02:33 INFO - Running main action method: clobber 15:02:33 INFO - rmtree: /builds/slave/test/build 15:02:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:02:33 INFO - Running post-action listener: _resource_record_post_action 15:02:33 INFO - ##### 15:02:33 INFO - ##### Running read-buildbot-config step. 15:02:33 INFO - ##### 15:02:33 INFO - Running pre-action listener: _resource_record_pre_action 15:02:33 INFO - Running main action method: read_buildbot_config 15:02:33 INFO - Using buildbot properties: 15:02:33 INFO - { 15:02:33 INFO - "project": "", 15:02:33 INFO - "product": "firefox", 15:02:33 INFO - "script_repo_revision": "production", 15:02:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:02:33 INFO - "repository": "", 15:02:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:02:33 INFO - "buildid": "20160309140824", 15:02:33 INFO - "pgo_build": "False", 15:02:33 INFO - "basedir": "/builds/slave/test", 15:02:33 INFO - "buildnumber": 1424, 15:02:33 INFO - "slavename": "talos-linux64-ix-049", 15:02:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:02:33 INFO - "platform": "ubuntu64_hw", 15:02:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:02:33 INFO - "branch": "fx-team", 15:02:33 INFO - "repo_path": "integration/fx-team", 15:02:33 INFO - "revision": "3282a189323c8ea9d2f5ae52e18a2cb4f50873c8", 15:02:33 INFO - "stage_platform": "linux64", 15:02:33 INFO - "builduid": "0d5f914caa0b400ebc9575dfab15815e", 15:02:33 INFO - "slavebuilddir": "test" 15:02:33 INFO - } 15:02:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:02:33 INFO - Running post-action listener: _resource_record_post_action 15:02:33 INFO - ##### 15:02:33 INFO - ##### Running download-and-extract step. 15:02:33 INFO - ##### 15:02:33 INFO - Running pre-action listener: _resource_record_pre_action 15:02:33 INFO - Running main action method: download_and_extract 15:02:33 INFO - mkdir: /builds/slave/test/build/tests 15:02: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:02:33 INFO - https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:02:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:02:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:02:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:35 INFO - Downloaded 1361 bytes. 15:02:35 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:02:35 INFO - Using the following test package requirements: 15:02:35 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:02:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:02:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:35 INFO - u'jsshell-linux-x86_64.zip'], 15:02:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:02:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:02:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:02:35 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:02:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:02:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:02:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:02:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:02: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:02:35 INFO - https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:36 INFO - Downloaded 22091896 bytes. 15:02:36 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:02:36 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:02:37 INFO - Return code: 0 15:02:37 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:02:37 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:02:37 INFO - https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:38 INFO - Downloaded 22091896 bytes. 15:02:38 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:02:38 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:02:39 INFO - Return code: 0 15:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:39 INFO - https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:40 INFO - Downloaded 10845161 bytes. 15:02:40 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:02:40 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:02:40 INFO - Return code: 0 15:02: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:02:40 INFO - https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LBOW-rVcRceh9OSgtKQw9w/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:02:44 INFO - Downloaded 54413943 bytes. 15:02:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:02:44 INFO - mkdir: /builds/slave/test/properties 15:02:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:02:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:02:44 INFO - Contents: 15:02:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:02:45 INFO - Running post-action listener: _resource_record_post_action 15:02:45 INFO - Running post-action listener: set_extra_try_arguments 15:02:45 INFO - ##### 15:02:45 INFO - ##### Running populate-webroot step. 15:02:45 INFO - ##### 15:02:45 INFO - Running pre-action listener: _resource_record_pre_action 15:02:45 INFO - Running main action method: populate_webroot 15:02:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:02:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:02:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:02:45 INFO - '--tppagecycles', 15:02:45 INFO - '7'], 15:02:45 INFO - 'tests': ['tsvgm']}}, 15:02:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:02:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:02:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:02:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:02:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:45 INFO - 'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:02:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:45 INFO - 'tests': ['damp', 'tps']}, 15:02:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:45 INFO - 'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['damp', 'tps']}, 15:02:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:02:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:02:45 INFO - 'other': {'tests': ['a11yr', 15:02:45 INFO - 'ts_paint', 15:02:45 INFO - 'tpaint', 15:02:45 INFO - 'sessionrestore', 15:02:45 INFO - 'sessionrestore_no_auto_restore', 15:02:45 INFO - 'tabpaint']}, 15:02:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['a11yr', 15:02:45 INFO - 'ts_paint', 15:02:45 INFO - 'tpaint', 15:02:45 INFO - 'sessionrestore', 15:02:45 INFO - 'sessionrestore_no_auto_restore', 15:02:45 INFO - 'tabpaint']}, 15:02:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['a11yr', 15:02:45 INFO - 'ts_paint', 15:02:45 INFO - 'tpaint', 15:02:45 INFO - 'sessionrestore', 15:02:45 INFO - 'sessionrestore_no_auto_restore', 15:02:45 INFO - 'tabpaint']}, 15:02:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['a11yr', 15:02:45 INFO - 'ts_paint', 15:02:45 INFO - 'tpaint', 15:02:45 INFO - 'sessionrestore', 15:02:45 INFO - 'sessionrestore_no_auto_restore', 15:02:45 INFO - 'tabpaint']}, 15:02:45 INFO - 'other_l64': {'tests': ['a11yr', 15:02:45 INFO - 'ts_paint', 15:02:45 INFO - 'tpaint', 15:02:45 INFO - 'sessionrestore', 15:02:45 INFO - 'sessionrestore_no_auto_restore', 15:02:45 INFO - 'tabpaint']}, 15:02:45 INFO - 'other_nol64': {'tests': ['a11yr', 15:02:45 INFO - 'ts_paint', 15:02:45 INFO - 'tpaint', 15:02:45 INFO - 'sessionrestore', 15:02:45 INFO - 'sessionrestore_no_auto_restore', 15:02:45 INFO - 'tabpaint']}, 15:02:45 INFO - 'svgr': {'tests': ['tsvgx', 15:02:45 INFO - 'tsvgr_opacity', 15:02:45 INFO - 'tart', 15:02:45 INFO - 'tscrollx', 15:02:45 INFO - 'cart']}, 15:02:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['tsvgx', 15:02:45 INFO - 'tsvgr_opacity', 15:02:45 INFO - 'tart', 15:02:45 INFO - 'tscrollx', 15:02:45 INFO - 'cart']}, 15:02:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:45 INFO - 'tests': ['tp5o']}, 15:02:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:45 INFO - 'talos_options': ['--e10s'], 15:02:45 INFO - 'tests': ['tp5o']}, 15:02:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:45 INFO - 'talos_options': ['--xperf_path', 15:02:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:45 INFO - 'tests': ['tp5n']}, 15:02:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:02:45 INFO - 'talos_options': ['--e10s', 15:02:45 INFO - '--xperf_path', 15:02:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:02:45 INFO - 'tests': ['tp5n']}}, 15:02:45 INFO - 'talos.zip': {'path': '', 15:02:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:02:45 INFO - Running post-action listener: _resource_record_post_action 15:02:45 INFO - ##### 15:02:45 INFO - ##### Running create-virtualenv step. 15:02:45 INFO - ##### 15:02:45 INFO - Running pre-action listener: _resource_record_pre_action 15:02:45 INFO - Running main action method: create_virtualenv 15:02:45 INFO - Creating virtualenv /builds/slave/test/build/venv 15:02:45 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:02:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:02:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:02:45 INFO - Using real prefix '/usr' 15:02:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:02:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:02:47 INFO - Installing pip.................done. 15:02:47 INFO - Return code: 0 15:02:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:47 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 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:02:47 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:02:47 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:02:47 INFO - Using env: {'DISPLAY': ':0', 15:02:47 INFO - 'HOME': '/home/cltbld', 15:02:47 INFO - 'LANG': 'en_US.UTF-8', 15:02:47 INFO - 'LANGUAGE': 'en_US:en', 15:02:47 INFO - 'LOGNAME': 'cltbld', 15:02:47 INFO - 'MAIL': '/var/mail/cltbld', 15:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:47 INFO - 'MOZ_NO_REMOTE': '1', 15:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:47 INFO - 'NO_EM_RESTART': '1', 15:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:47 INFO - 'PWD': '/builds/slave/test', 15:02:47 INFO - 'SHELL': '/bin/bash', 15:02:47 INFO - 'SHLVL': '1', 15:02:47 INFO - 'TERM': 'linux', 15:02:47 INFO - 'TMOUT': '86400', 15:02:47 INFO - 'USER': 'cltbld', 15:02:47 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:47 INFO - '_': '/tools/buildbot/bin/python'} 15:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:48 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:02:48 INFO - Cleaning up... 15:02:48 INFO - Return code: 0 15:02:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:48 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 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:02:48 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:02:48 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:02:48 INFO - Using env: {'DISPLAY': ':0', 15:02:48 INFO - 'HOME': '/home/cltbld', 15:02:48 INFO - 'LANG': 'en_US.UTF-8', 15:02:48 INFO - 'LANGUAGE': 'en_US:en', 15:02:48 INFO - 'LOGNAME': 'cltbld', 15:02:48 INFO - 'MAIL': '/var/mail/cltbld', 15:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:48 INFO - 'MOZ_NO_REMOTE': '1', 15:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:48 INFO - 'NO_EM_RESTART': '1', 15:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:48 INFO - 'PWD': '/builds/slave/test', 15:02:48 INFO - 'SHELL': '/bin/bash', 15:02:48 INFO - 'SHLVL': '1', 15:02:48 INFO - 'TERM': 'linux', 15:02:48 INFO - 'TMOUT': '86400', 15:02:48 INFO - 'USER': 'cltbld', 15:02:48 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:48 INFO - '_': '/tools/buildbot/bin/python'} 15:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:48 INFO - Downloading/unpacking psutil>=0.7.1 15:02:48 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:02:48 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:02:48 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:02:48 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:02:48 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:02:48 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:02:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:02:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:50 INFO - Installing collected packages: psutil 15:02:50 INFO - Running setup.py install for psutil 15:02:50 INFO - building 'psutil._psutil_linux' extension 15:02:50 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:02:50 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:02:50 INFO - building 'psutil._psutil_posix' extension 15:02:50 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:02:50 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:02:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:02:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:02:50 INFO - Successfully installed psutil 15:02:50 INFO - Cleaning up... 15:02:50 INFO - Return code: 0 15:02:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:02:50 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:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:50 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:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:50 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 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:02:50 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:02:50 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:02:50 INFO - Using env: {'DISPLAY': ':0', 15:02:50 INFO - 'HOME': '/home/cltbld', 15:02:50 INFO - 'LANG': 'en_US.UTF-8', 15:02:50 INFO - 'LANGUAGE': 'en_US:en', 15:02:50 INFO - 'LOGNAME': 'cltbld', 15:02:50 INFO - 'MAIL': '/var/mail/cltbld', 15:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:50 INFO - 'MOZ_NO_REMOTE': '1', 15:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:50 INFO - 'NO_EM_RESTART': '1', 15:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:50 INFO - 'PWD': '/builds/slave/test', 15:02:50 INFO - 'SHELL': '/bin/bash', 15:02:50 INFO - 'SHLVL': '1', 15:02:50 INFO - 'TERM': 'linux', 15:02:50 INFO - 'TMOUT': '86400', 15:02:50 INFO - 'USER': 'cltbld', 15:02:50 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:50 INFO - '_': '/tools/buildbot/bin/python'} 15:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:02:51 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:02:51 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:02:51 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:02:51 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:02:51 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:02:51 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:02:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:02:52 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:02:52 INFO - Installing collected packages: mozsystemmonitor 15:02:52 INFO - Running setup.py install for mozsystemmonitor 15:02:52 INFO - Successfully installed mozsystemmonitor 15:02:52 INFO - Cleaning up... 15:02:53 INFO - Return code: 0 15:02:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:02: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:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:02:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:02:53 INFO - Using env: {'DISPLAY': ':0', 15:02:53 INFO - 'HOME': '/home/cltbld', 15:02:53 INFO - 'LANG': 'en_US.UTF-8', 15:02:53 INFO - 'LANGUAGE': 'en_US:en', 15:02:53 INFO - 'LOGNAME': 'cltbld', 15:02:53 INFO - 'MAIL': '/var/mail/cltbld', 15:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:53 INFO - 'MOZ_NO_REMOTE': '1', 15:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:53 INFO - 'NO_EM_RESTART': '1', 15:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:53 INFO - 'PWD': '/builds/slave/test', 15:02:53 INFO - 'SHELL': '/bin/bash', 15:02:53 INFO - 'SHLVL': '1', 15:02:53 INFO - 'TERM': 'linux', 15:02:53 INFO - 'TMOUT': '86400', 15:02:53 INFO - 'USER': 'cltbld', 15:02:53 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:53 INFO - '_': '/tools/buildbot/bin/python'} 15:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:02:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:02:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:55 INFO - Downloading docopt-0.6.1.tar.gz 15:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:02:55 INFO - Installing collected packages: blobuploader, requests, docopt 15:02:55 INFO - Running setup.py install for blobuploader 15:02:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:02:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:02:55 INFO - Running setup.py install for requests 15:02:56 INFO - Running setup.py install for docopt 15:02:56 INFO - Successfully installed blobuploader requests docopt 15:02:56 INFO - Cleaning up... 15:02:56 INFO - Return code: 0 15:02:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02: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:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02: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:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:56 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 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:02:56 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:02:56 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:02:56 INFO - Using env: {'DISPLAY': ':0', 15:02:56 INFO - 'HOME': '/home/cltbld', 15:02:56 INFO - 'LANG': 'en_US.UTF-8', 15:02:56 INFO - 'LANGUAGE': 'en_US:en', 15:02:56 INFO - 'LOGNAME': 'cltbld', 15:02:56 INFO - 'MAIL': '/var/mail/cltbld', 15:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:56 INFO - 'MOZ_NO_REMOTE': '1', 15:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:56 INFO - 'NO_EM_RESTART': '1', 15:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:56 INFO - 'PWD': '/builds/slave/test', 15:02:56 INFO - 'SHELL': '/bin/bash', 15:02:56 INFO - 'SHLVL': '1', 15:02:56 INFO - 'TERM': 'linux', 15:02:56 INFO - 'TMOUT': '86400', 15:02:56 INFO - 'USER': 'cltbld', 15:02:56 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:56 INFO - '_': '/tools/buildbot/bin/python'} 15:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:56 INFO - Running setup.py (path:/tmp/pip-eK2ulr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:56 INFO - Running setup.py (path:/tmp/pip-mgyqad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:56 INFO - Running setup.py (path:/tmp/pip-8f7NZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:02:56 INFO - Running setup.py (path:/tmp/pip-Il67W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:02:56 INFO - Running setup.py (path:/tmp/pip-OJEwN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:02:56 INFO - Running setup.py (path:/tmp/pip-8dg_jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:02:57 INFO - Running setup.py (path:/tmp/pip-a63MPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:02:57 INFO - Running setup.py (path:/tmp/pip-6tFWUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:02:57 INFO - Running setup.py (path:/tmp/pip-BddT_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:02:57 INFO - Running setup.py (path:/tmp/pip-vZiTUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:02:57 INFO - Running setup.py (path:/tmp/pip-1wq25y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:02:57 INFO - Running setup.py (path:/tmp/pip-rsMeDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:02:57 INFO - Running setup.py (path:/tmp/pip-jQVZti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:02:57 INFO - Running setup.py (path:/tmp/pip-t4biQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:57 INFO - Running setup.py (path:/tmp/pip-mFbmTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:02:57 INFO - Running setup.py (path:/tmp/pip-XUV6LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:02:57 INFO - Running setup.py (path:/tmp/pip-xwhZrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:02:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:02:57 INFO - Running setup.py install for manifestparser 15:02:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:02:57 INFO - Running setup.py install for mozcrash 15:02:58 INFO - Running setup.py install for mozdebug 15:02:58 INFO - Running setup.py install for mozdevice 15:02:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Running setup.py install for mozfile 15:02:58 INFO - Running setup.py install for mozhttpd 15:02:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Running setup.py install for mozinfo 15:02:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Running setup.py install for mozInstall 15:02:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Running setup.py install for mozleak 15:02:58 INFO - Running setup.py install for mozlog 15:02:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Running setup.py install for moznetwork 15:02:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:02:58 INFO - Running setup.py install for mozprocess 15:02:59 INFO - Running setup.py install for mozprofile 15:02:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:02:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:02:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:02:59 INFO - Running setup.py install for mozrunner 15:02:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:02:59 INFO - Running setup.py install for mozscreenshot 15:02:59 INFO - Running setup.py install for moztest 15:02:59 INFO - Running setup.py install for mozversion 15:02:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:02:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:02:59 INFO - Cleaning up... 15:02:59 INFO - Return code: 0 15:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:59 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:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:59 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:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:59 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 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:02:59 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:02:59 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:02:59 INFO - Using env: {'DISPLAY': ':0', 15:02:59 INFO - 'HOME': '/home/cltbld', 15:02:59 INFO - 'LANG': 'en_US.UTF-8', 15:02:59 INFO - 'LANGUAGE': 'en_US:en', 15:02:59 INFO - 'LOGNAME': 'cltbld', 15:02:59 INFO - 'MAIL': '/var/mail/cltbld', 15:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:59 INFO - 'MOZ_NO_REMOTE': '1', 15:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:59 INFO - 'NO_EM_RESTART': '1', 15:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:59 INFO - 'PWD': '/builds/slave/test', 15:02:59 INFO - 'SHELL': '/bin/bash', 15:02:59 INFO - 'SHLVL': '1', 15:02:59 INFO - 'TERM': 'linux', 15:02:59 INFO - 'TMOUT': '86400', 15:02:59 INFO - 'USER': 'cltbld', 15:02:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:59 INFO - '_': '/tools/buildbot/bin/python'} 15:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:02:59 INFO - Running setup.py (path:/tmp/pip-PzLAnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:02:59 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:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:02:59 INFO - Running setup.py (path:/tmp/pip-O1GiXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:02:59 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:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:02:59 INFO - Running setup.py (path:/tmp/pip-zGjGoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:03:00 INFO - Running setup.py (path:/tmp/pip-VQaAFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:03:00 INFO - Running setup.py (path:/tmp/pip-PMRWAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:03:00 INFO - Running setup.py (path:/tmp/pip-qQBaFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:03:00 INFO - Running setup.py (path:/tmp/pip-VLGpl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:03:00 INFO - Running setup.py (path:/tmp/pip-LwZ63u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:03:00 INFO - Running setup.py (path:/tmp/pip-t9Zjqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:03:00 INFO - Running setup.py (path:/tmp/pip-j7yq6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:03:00 INFO - Running setup.py (path:/tmp/pip-6o4fAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:03:00 INFO - Running setup.py (path:/tmp/pip-4jJC2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:03:00 INFO - Running setup.py (path:/tmp/pip-9_bUtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:03:00 INFO - Running setup.py (path:/tmp/pip-wiapzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:00 INFO - Running setup.py (path:/tmp/pip-0ODWDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:03:00 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:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:03:00 INFO - Running setup.py (path:/tmp/pip-knrGrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:03:01 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:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:03:01 INFO - Running setup.py (path:/tmp/pip-OF2Awx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:03:01 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:03:01 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:03:01 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:03:01 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:03:01 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:03:01 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:03:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:03: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:03: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:03: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:03: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:03: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:03: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:03:02 INFO - Downloading blessings-1.6.tar.gz 15:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:03:02 INFO - Installing collected packages: blessings 15:03:02 INFO - Running setup.py install for blessings 15:03:03 INFO - Successfully installed blessings 15:03:03 INFO - Cleaning up... 15:03:03 INFO - Return code: 0 15:03:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:03:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:03 INFO - Reading from file tmpfile_stdout 15:03:03 INFO - Current package versions: 15:03:03 INFO - argparse == 1.2.1 15:03:03 INFO - blessings == 1.6 15:03:03 INFO - blobuploader == 1.2.4 15:03:03 INFO - docopt == 0.6.1 15:03:03 INFO - manifestparser == 1.1 15:03:03 INFO - mozInstall == 1.12 15:03:03 INFO - mozcrash == 0.17 15:03:03 INFO - mozdebug == 0.1 15:03:03 INFO - mozdevice == 0.48 15:03:03 INFO - mozfile == 1.2 15:03:03 INFO - mozhttpd == 0.7 15:03:03 INFO - mozinfo == 0.9 15:03:03 INFO - mozleak == 0.1 15:03:03 INFO - mozlog == 3.1 15:03:03 INFO - moznetwork == 0.27 15:03:03 INFO - mozprocess == 0.22 15:03:03 INFO - mozprofile == 0.28 15:03:03 INFO - mozrunner == 6.11 15:03:03 INFO - mozscreenshot == 0.1 15:03:03 INFO - mozsystemmonitor == 0.0 15:03:03 INFO - moztest == 0.7 15:03:03 INFO - mozversion == 1.4 15:03:03 INFO - psutil == 3.1.1 15:03:03 INFO - requests == 1.2.3 15:03:03 INFO - wsgiref == 0.1.2 15:03:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:03: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:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:03 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 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:03:03 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:03:03 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:03:03 INFO - Using env: {'DISPLAY': ':0', 15:03:03 INFO - 'HOME': '/home/cltbld', 15:03:03 INFO - 'LANG': 'en_US.UTF-8', 15:03:03 INFO - 'LANGUAGE': 'en_US:en', 15:03:03 INFO - 'LOGNAME': 'cltbld', 15:03:03 INFO - 'MAIL': '/var/mail/cltbld', 15:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:03 INFO - 'MOZ_NO_REMOTE': '1', 15:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:03 INFO - 'NO_EM_RESTART': '1', 15:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:03 INFO - 'PWD': '/builds/slave/test', 15:03:03 INFO - 'SHELL': '/bin/bash', 15:03:03 INFO - 'SHLVL': '1', 15:03:03 INFO - 'TERM': 'linux', 15:03:03 INFO - 'TMOUT': '86400', 15:03:03 INFO - 'USER': 'cltbld', 15:03:03 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:03 INFO - '_': '/tools/buildbot/bin/python'} 15:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 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:03:03 INFO - Cleaning up... 15:03:03 INFO - Return code: 0 15:03:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:03: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:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:03: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', 'jsonschema'] in /builds/slave/test/build 15:03: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 jsonschema 15:03:03 INFO - Using env: {'DISPLAY': ':0', 15:03:03 INFO - 'HOME': '/home/cltbld', 15:03:03 INFO - 'LANG': 'en_US.UTF-8', 15:03:03 INFO - 'LANGUAGE': 'en_US:en', 15:03:03 INFO - 'LOGNAME': 'cltbld', 15:03:03 INFO - 'MAIL': '/var/mail/cltbld', 15:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:03 INFO - 'MOZ_NO_REMOTE': '1', 15:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:03 INFO - 'NO_EM_RESTART': '1', 15:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:03 INFO - 'PWD': '/builds/slave/test', 15:03:03 INFO - 'SHELL': '/bin/bash', 15:03:03 INFO - 'SHLVL': '1', 15:03:03 INFO - 'TERM': 'linux', 15:03:03 INFO - 'TMOUT': '86400', 15:03:03 INFO - 'USER': 'cltbld', 15:03:03 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:03 INFO - '_': '/tools/buildbot/bin/python'} 15:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:03 INFO - Downloading/unpacking jsonschema 15:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:03:05 INFO - Downloading/unpacking functools32 (from jsonschema) 15:03: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:03: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:03: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:03: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:03: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:03: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:03:06 INFO - Downloading functools32-3.2.3-2.tar.gz 15:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:03:06 INFO - warning: no files found matching '*.txt' 15:03:06 INFO - no previously-included directories found matching 'build' 15:03:06 INFO - no previously-included directories found matching 'dist' 15:03:06 INFO - no previously-included directories found matching '.git*' 15:03:06 INFO - Installing collected packages: jsonschema, functools32 15:03:06 INFO - Running setup.py install for functools32 15:03:06 INFO - warning: no files found matching '*.txt' 15:03:06 INFO - no previously-included directories found matching 'build' 15:03:06 INFO - no previously-included directories found matching 'dist' 15:03:06 INFO - no previously-included directories found matching '.git*' 15:03:06 INFO - Successfully installed jsonschema functools32 15:03:06 INFO - Cleaning up... 15:03:06 INFO - Return code: 0 15:03:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:03:06 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:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:06 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:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:06 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 0x7f2da16cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', '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:03:06 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:03:06 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:03:06 INFO - Using env: {'DISPLAY': ':0', 15:03:06 INFO - 'HOME': '/home/cltbld', 15:03:06 INFO - 'LANG': 'en_US.UTF-8', 15:03:06 INFO - 'LANGUAGE': 'en_US:en', 15:03:06 INFO - 'LOGNAME': 'cltbld', 15:03:06 INFO - 'MAIL': '/var/mail/cltbld', 15:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:06 INFO - 'MOZ_NO_REMOTE': '1', 15:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:06 INFO - 'NO_EM_RESTART': '1', 15:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:06 INFO - 'PWD': '/builds/slave/test', 15:03:06 INFO - 'SHELL': '/bin/bash', 15:03:06 INFO - 'SHLVL': '1', 15:03:06 INFO - 'TERM': 'linux', 15:03:06 INFO - 'TMOUT': '86400', 15:03:06 INFO - 'USER': 'cltbld', 15:03:06 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:06 INFO - '_': '/tools/buildbot/bin/python'} 15:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:06 INFO - Downloading/unpacking flake8 15:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:03:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:03:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:03:09 INFO - no previously-included directories found matching 'docs/_build' 15:03:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:03:09 INFO - Running setup.py install for pep8 15:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:03:09 INFO - no previously-included directories found matching 'docs/_build' 15:03:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:03:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:03:09 INFO - Cleaning up... 15:03:09 INFO - Return code: 0 15:03:09 INFO - Running post-action listener: _resource_record_post_action 15:03:09 INFO - Running post-action listener: _start_resource_monitoring 15:03:09 INFO - Starting resource monitoring. 15:03:09 INFO - ##### 15:03:09 INFO - ##### Running install step. 15:03:09 INFO - ##### 15:03:09 INFO - Running pre-action listener: _resource_record_pre_action 15:03:09 INFO - Running main action method: install 15:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:03:09 INFO - Reading from file tmpfile_stdout 15:03:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:03:09 INFO - Reading from file tmpfile_stdout 15:03:09 INFO - Output received: 15:03:09 INFO - Usage: mozinstall [options] installer 15:03:09 INFO - Options: 15:03:09 INFO - -h, --help show this help message and exit 15:03:09 INFO - -d DEST, --destination=DEST 15:03:09 INFO - Directory to install application into. [default: 15:03:09 INFO - "/builds/slave/test"] 15:03:09 INFO - --app=APP Application being installed. [default: firefox] 15:03:09 INFO - mkdir: /builds/slave/test/build/application 15:03:09 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:03:09 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:03:25 INFO - Reading from file tmpfile_stdout 15:03:25 INFO - Output received: 15:03:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:03:25 INFO - Running post-action listener: _resource_record_post_action 15:03:25 INFO - ##### 15:03:25 INFO - ##### Running run-tests step. 15:03:25 INFO - ##### 15:03:25 INFO - Running pre-action listener: _resource_record_pre_action 15:03:25 INFO - Running main action method: run_tests 15:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:03:25 INFO - Python 2.7.3 15:03:25 INFO - Return code: 0 15:03:25 INFO - grabbing minidump binary from tooltool 15:03:25 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:03:25 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 0x2bb9160>, '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 0x2bba060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bba4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:03:25 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:03:25 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:03:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:03:25 INFO - Return code: 0 15:03:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:03:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:03:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:03:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:03:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:03:26 INFO - Return code: 0 15:03:26 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/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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:03:26 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/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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:03:26 INFO - Using env: {'DISPLAY': ':0', 15:03:26 INFO - 'HOME': '/home/cltbld', 15:03:26 INFO - 'LANG': 'en_US.UTF-8', 15:03:26 INFO - 'LANGUAGE': 'en_US:en', 15:03:26 INFO - 'LOGNAME': 'cltbld', 15:03:26 INFO - 'MAIL': '/var/mail/cltbld', 15:03:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:03:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:26 INFO - 'MOZ_NO_REMOTE': '1', 15:03:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:03:26 INFO - 'NO_EM_RESTART': '1', 15:03:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:26 INFO - 'PWD': '/builds/slave/test', 15:03:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:03:26 INFO - 'SHELL': '/bin/bash', 15:03:26 INFO - 'SHLVL': '1', 15:03:26 INFO - 'TERM': 'linux', 15:03:26 INFO - 'TMOUT': '86400', 15:03:26 INFO - 'USER': 'cltbld', 15:03:26 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511', 15:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:26 INFO - '_': '/tools/buildbot/bin/python'} 15:03:26 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/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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:03:26 INFO - mozversion application_buildid: 20160309140824 15:03:26 INFO - mozversion application_changeset: 3282a189323c8ea9d2f5ae52e18a2cb4f50873c8 15:03:26 INFO - mozversion application_display_name: Nightly 15:03:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:03:26 INFO - mozversion application_name: Firefox 15:03:26 INFO - mozversion application_remotingname: firefox 15:03:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:03:26 INFO - mozversion application_vendor: Mozilla 15:03:26 INFO - mozversion application_version: 48.0a1 15:03:26 INFO - mozversion platform_buildid: 20160309140824 15:03:26 INFO - mozversion platform_changeset: 3282a189323c8ea9d2f5ae52e18a2cb4f50873c8 15:03:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:03:26 INFO - mozversion platform_version: 48.0a1 15:03:26 INFO - using testdate: 1457564606 15:03:26 INFO - actual date: 1457564606 15:03:26 INFO - starting webserver on 'localhost:37819' 15:03:26 INFO - SUITE-START | Running 2 tests 15:03:26 INFO - TEST-START | dromaeo_css 15:03:26 INFO - operating with platform_type : linux_ 15:03:26 INFO - Initialising browser for dromaeo_css test... 15:03:26 INFO - TEST-INFO | started process 7617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn6IVjc/profile http://localhost:37819/getInfo.html) 15:03:31 INFO - PROCESS | 7617 | __metrics Screen width/height:1600/1200 15:03:31 INFO - PROCESS | 7617 | colorDepth:24 15:03:31 INFO - PROCESS | 7617 | Browser inner width/height: 1024/697 15:03:31 INFO - PROCESS | 7617 | __metrics 15:03:31 ERROR - PROCESS | 7617 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:03:32 INFO - PROCESS | 7617 | 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:03:32 INFO - TEST-INFO | 7617: exit 0 15:03:32 INFO - Browser initialized. 15:03:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:03:32 INFO - TEST-INFO | started process 7708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn6IVjc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:03:44 INFO - PROCESS | 7708 | RSS: Main: 153763840 15:03:44 INFO - PROCESS | 7708 | 15:04:36 INFO - PROCESS | 7708 | 1457564676164 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:06:47 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:37819/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37819/tests/dromaeo/cssquery-ext.html) 15:06:48 INFO - PROCESS | 7708 | RSS: Main: 272097280 15:06:48 INFO - PROCESS | 7708 | 15:09:51 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:37819/tests/dromaeo/cssquery-ext.html (next: http://localhost:37819/tests/dromaeo/cssquery-jquery.html) 15:09:51 INFO - PROCESS | 7708 | RSS: Main: 240586752 15:09:51 INFO - PROCESS | 7708 | 15:12:53 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:37819/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37819/tests/dromaeo/cssquery-mootools.html) 15:12:54 INFO - PROCESS | 7708 | RSS: Main: 236212224 15:12:54 INFO - PROCESS | 7708 | 15:15:56 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:37819/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37819/tests/dromaeo/cssquery-prototype.html) 15:15:56 INFO - PROCESS | 7708 | RSS: Main: 208089088 15:15:56 INFO - PROCESS | 7708 | 15:18:59 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:37819/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37819/tests/dromaeo/cssquery-yui.html) 15:18:59 INFO - PROCESS | 7708 | RSS: Main: 201416704 15:18:59 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:37819/tests/dromaeo/cssquery-yui.html (next: http://localhost:37819/tests/dromaeo/cssquery-dojo.html) 15:22:02 INFO - PROCESS | 7708 | RSS: Main: 269938688 15:22:02 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | __start_tp_report 15:22:02 INFO - PROCESS | 7708 | _x_x_mozilla_page_load 15:22:02 INFO - PROCESS | 7708 | _x_x_mozilla_page_load_details 15:22:02 INFO - PROCESS | 7708 | |i|pagename|runs| 15:22:02 INFO - PROCESS | 7708 | |0;dojo.html;2580.53550360935;2667.3198334424733;2678.825876318038;2685.9731402685966;2713.199606116195;4449.621782148522;4526.162659907911;4594.954050459494;4603.355530225767;4634.490206077328;4503.594676479124;4568.543145685429;4581.40441742573;4598.218302888508;4611.723296602207;4200.0339921818;4210.55789142141;4231.196072746168;4250.957490425087;4310.633596144332;4229.069604686964;4281.721688090264;4285.400043993844;4299.656027517807;4316.913661726763;4059.0867054912705;4136.482939632546;4230.725002874803;4242.91514169718;4310.836074259948;4177.770222637754;4206.537280899099;4223.176480586287;4236.830526778926;4257.936130958038;4167.312393455076;4173.373993900909;4182;4194.832206711728;4209.031922657806;4343.326784348431;4480.798364073592;4483.461984561841;4483.843065492725;4514.074614704011;4898.093852637274;4903.509649035068;4905.607551395879;4931.950680493185;4952.67807592509;4918.336024636664;4924.679895806761;4925.926111108336;4929.507049295078;4957.355543779286;4444.933326000112;4554.294084416921;4568.200564901163;4577.908441831178;4617.769111544477;4979.278004689372;4998.2502624606595;5001.924971125436;5004.674696144739;5034.798608055637;4790.089882922233;4802.8799280018275;4805.783739731721;4807;4840.636952228527;4777.235642297216;4867.659263851497;4918.188498897642;4937.753112344369;4945.23348880924;4852.733099679552;4863.829765958175;4872.926906096412;4884.242942343943;4927.679700819435;4861;4866.7566621668775;4880.41435027799;4888.511148885154;4934.136526107988;3969.126792105732;4007.5391329997424;4034.092329225901;4075.1238483726142;4075.612816782401;3590.8204589770407;3591.1919818040733;3602.3155600435834;3636.890893273206;3638.9636103639154;4213.705040647186;4221;4221.746695198237;4224.302990006676;4259.38238955356;4746.525347465225;4863.2461968394955;4899.387576552931;4943.8516844494725;4950.752462376867;4152.314868046798;4171.853985110507;4187;4188.623023927861;4221.113566151143;4246.4691913510815;4309.719868208556;4310.52584215736;4336.804843782037;4345.739255644671;4585.10590434862;4617.9769101155625;4633.86098417048;4660.790264438041;4666.650001249987;4864.416270047617;4870.683405578626;4882;4889.804407823647;4911.066897289504;4597.60920321763;4639.559241872017;4643.207709925902;4674.11191873543;4690.413698287714;4906.607471402351;4920.778564964514;4921.966387058757;4953.7523123844385;4968.602511799119;4974.32846565709;4976.353074100344;4983.202687569971;4988.5260900214425;5028.698278103326;4651.5813576778255;4707.646926480596;4776.641751868554;4826.613870890391;4875.6099512038245;4679.836205732783;4690.038542098793;4695.084458530554;4731.4322281325085;4741.9051618968115;4625.283081122431;4625.722456652612;4628.930566041579;4631.096936097429;4672.696274742131;4654.394928659252;4666.3700400445505;4738.052389522179;4748.074125545486;4812.51874812516;4601.792919318706;4609.124266389375;4663.440387153563;4674.579287864109;4692.41344831896 15:22:02 INFO - PROCESS | 7708 | |1;ext.html;494.9925751113733;500.46200334640247;509.671262035987;515.2580284390478;539.935207775067;25602.231933041992;34356.48465273023;34789.95630131097;34852.3029539409;34922.82538587304;38245.617543824555;38593;38710.419343709866;38711.61288387115;38839.61160388403;7532.322091011808;7726.381889448859;7731.45879788415;7732.188120247378;7734.226577342249;7686.269804368604;7813.843723125534;7830.177831327714;7832.921670783277;7834.960825195866;7802.297793198611;8061.6372263248295;8080.717174898879;8085.07021692507;8088.676452941875;7902.841943161134;7975.2423519765525;7979.56112413817;8000.919990800134;8002.67989280431;7778.299953004257;7825.686972521093;7897.842043159162;7915.485493442965;7916.881246781303;37858.62141378606;38263.808680956696;38324.616753832386;38332.80833595814;38377;2835.064428738511;2891.7108289170915;2896.493113705093;3002.3094688221613;3206.7594930380315;28973;29125.708742912513;29266.122016339545;29790.404191916256;30530.38939221203;3455.6371580984137;3512.4731290306404;3526.0655926179584;3526.488659144435;3590.964090359089;181239;181686;182383;182778;182982;38469.61530384716;39612.80193599071;52575.21137182946;53005;53089.469105309225;36843.63156368402;36844.81577592149;36882.44676329857;36930.815345923096;37043.629563704555;11236.438178091226;11409.030232430336;11413.429328533706;11417.942910285561;11420.543178272776;8785.428947118417;8924.598393072327;8935.731928042169;8944.8658270126;8948.926128864578;12914.806277905838;13377.66555836112;13388.330583470788;13425.194488330731;13513.121647092907;5264.315638966987;5313.229581710631;5326.201069839555;5393.514583687487;5396.541293990055;729.3326606155415;759.2673070486896;867.21786728274;927.5640448988964;1017.6082208349839;25609;25963.22110336693;26323.73676263251;26410.86794566015;26437.73562264391;725.4812808841598;902.6163880350824;929.5538141692026;1027.0807627173638;1031.1441503552035;12099.637010889688;12286.324252166216;12309.076819238413;12495.250284982749;12518.561850335194;262990;266602;267567;267932;268199;42837.785811070746;43229.35155972663;43381.78309108497;43437.782811085744;43440.13119737588;1102.7298311913632;1124.42092322454;1153.9019183369508;1157.5890558851654;1211.0856303490807;23816.88091559531;25942.35144121412;26509.204723858315;26915.730842691322;26963.730362696122;32961.175970600925;32978.17554561155;33140.83429582933;33170.66829331676;33177.17057073592;182205;183299;183390;183521;184112;24350.391240219134;28149;29201.561976570792;29552.408951820413;29690.703092968793;32896.83551582227;33639.66360336365;34040;34184.48723269103;37126.25747485089;31516.369672606877;31744.206394840312;31862.681373186897;31883.840580797874;31906.36187276195;31803.840980794947;31979.520307194944;32120.678793212704;32339.19152021218;32395;32189.55147018343;32535.51196732098;32814.67185328212;32826.50760238551;32857.17857053593;26580.775218553932;29257.97597084092;29273.560896586994;29303.706962930097;29356.266093347836;20912.581748365254;21119.260825871635;21259.8937005314;21267.680984784933;21313 15:22:02 INFO - PROCESS | 7708 | |2;jquery.html;328.9506574013898;333.1022893302549;339.44670187594215;345.2370261721595;350.59856464348337;14581.708365832677;15029.699406011901;15210.16344101074;15403.306851191695;15738.527844164679;14179.858201418008;14663;14906.47827326041;15511.844881551182;15530.53408397747;5019.698818070919;5148.922766158511;5189.455107213745;5193.558547523447;5205.687658740488;5013.448520662742;5142.074426603229;5222.895542089156;5230.163173892178;5233.947660523384;5187.688738675692;5194.532492075712;5209.479052094779;5209.973950130244;5215.660982036175;5033.949660503385;5159.019786240602;5166.018456493254;5269.314989051399;5273.499017593323;5064.5441910228255;5085.516875896784;5085.720285384303;5092.363454568179;5113.181890897438;10982.011618954333;11876.821847672292;18949.526261843428;18951.431457056173;18959.62080758377;1658.8507034366844;1672.5149706585198;1690.2140504665267;1716.7596536484903;1759.498542915263;8761.08008659088;8992.14574615417;9071.183593476619;9239.307051971062;11929.761404771943;1702.5488245614922;1741.4079213067491;1759.876808623397;1813.6644720726576;1858.1452531835373;52392.21411678828;58120.709396452745;58567.121493177634;58686.70656646732;60389;9728.951355243178;9812.313138080408;9883.802323953481;9928.652497162564;9999.550020249106;12559.372031398394;12765.68085797844;12766.361681915867;12768.680782980315;12771.425285862158;6591.274959754423;6645.966770166215;6692.063111164441;6798.082258895085;6802.319768023257;6163.075538669146;6216.378362163748;6319.33646967071;6338.651374174372;6352.7141278642575;4046.5548789633117;4069;4217.725847819882;4348.456442944632;4358.8038538265855;1607.686501132268;1660.5101495058987;1686.9325226990784;1711.9400820971207;1721.9052952087504;715.5277516838861;810.088650268448;829.3986859526915;921.6866265469772;942.9104235097655;15316.927815053063;15357.9232103841;15481.767773483407;15892.364305427885;16019.599510012344;789.7709664197318;806.028735373873;815.6900377856376;839.9118092600311;842.9915700843036;8688.131186881388;8878.334124940526;9119.81760364789;9207.40151890125;9258.768530786649;275965;375894;391724;393705;394642;60065;60632.69683651553;60938;62660.37339626637;62784.37215627785;903.2864037410503;909.4406939732149;932.5710173320349;932.7528205025674;947.6020071569819;14215.857841421453;14538.781918271447;14541.78187327212;14680.926595366955;14762.852371476578;30786;31062.68937310598;31486.842565787025;31721;32223.35553288968;41947;44267;44409.555904440545;44834.77582612066;44836.77581612071;6919.965400172967;7250.166230883516;7423.406127509678;7429.405647548075;7443.36731377839;8199.590020498832;10558.208134390105;11075.224734268524;11361.943190283995;11376.715582110513;9275.536223188948;9532.95233523828;9619.759506012406;9941.950290248502;9952.850707239542;9502.334836561375;9687.515624218902;9821.901780982385;9888.604455821687;10123.848142277724;10440.791184176425;10450.68647940563;10461.843072354073;10463.319884207502;10671.94664026675;7285.453590980804;7368.6315684214505;7423.220561841145;7452.143003554661;7457.47797654159;9153.405028673114;10200.271554650528;10242.590296388062;10273.434961076913;10471.633492827714 15:22:02 INFO - PROCESS | 7708 | |3;mootools.html;1223.3455101520688;1337.2912356451081;1344.932753362332;1456.8470310617386;1725.7842769653794;7182.604956727378;7318.5974771387555;7328.523645963009;7330.523515971458;7352.04423424954;7167.928320716791;7300.1604815446235;7319.7438089666875;7326.96336518318;7333.6333183340885;1803.891766494008;2154.192177933275;2190.5728382965326;2195.7584665686763;2208.86746795192;2223.2329846203115;2240.1263507232193;2243.5064285857084;2243.5849367866917;2244.5286489837154;2099.622068027762;2189.310367234324;2191.616467118256;2193.035064571591;2196.2203417786695;2148.291063948893;2178.4227179797367;2189.474526113729;2213.9557208855895;2224.277109939276;2188.803007729312;2200.9559808803892;2203.294945617403;2207.4371035386034;2210.613142700021;7402.777916662509;7447.9627601862185;7448.106227252711;7469.962650186769;7480.9251907480775;4503.639708823286;4622.422197225347;4635.2583586626315;4668.276417155346;4669.929951050737;2926.956095658567;2952.3652414730723;3012.0813151988636;3018.0493144659363;3046.57347971282;908.5230254116576;910.1808372464768;921.3550514639712;945.2910317262053;947.9099485548862;10544.420056896868;10547.314424562379;10595.470226488722;10616.57533698651;10628.256022078458;4273.487181538173;4387.122575484916;4444.2222611042935;4455.04216593434;4460.286354183315;8896.243819275305;8899.688510902088;8933.419327743675;8937.240334571505;8947.955260223658;3818.9236215276096;4691.319758635047;4704.741239231875;4709.95290047102;4731.455882573479;4046.979765101156;4108.322126849036;4110.383442483591;4117.835286588503;4133.028738246509;3514.139035936212;3606.693431058337;3607.74745767799;3629.8003609801713;3648.1062139775927;1075.1560025380195;1078.379931539368;1083.014456844268;1083.6586475260267;1130.0168853097693;1133.6145710458484;1143.3140115930375;1152.09560495011;1169.7485040716288;1206.6561030106377;7167.319104685047;7226.530275532074;7234.276572342724;7263.418926485869;7284.6721897514735;431.83158568158444;436.4893075102138;436.9191699535596;437.28285611597005;437.8883384736935;5259.8422047338645;5297.125974214211;5313.946860531422;5325.3875804282225;5603.2435621191435;9029.819403611891;9324.95337523308;9395.20140788027;9442.669506567374;9457.90542094584;9077.137671921157;9086;9260.629574816932;9274.165325120637;9306.208972237435;6965.5124141309625;7033.191183013917;7086;7121.82195445118;7133.251008644018;6743.730250789913;6796;6848.8972665409065;6851.143607049119;6935.791926242221;8194.713185038496;8269.21442462965;8382.70660526903;8408.579571021302;8455.704050358208;8408.87386689188;8507.404481686222;8648.78378040554;8649.913500865163;8664.566771661517;5684.516816070515;6179.969100154471;6399.2640846303275;6603.339666033358;6707.061011458497;7132;7134;7140.500164988401;7166.390856777024;7203.315685009916;6316.715747791269;6486.481081513373;6551.508636852351;6553.574017688835;6632.336766323329;6260.40526150015;6367.681615919093;6390.968045159744;6429.9678501607195;6535.869282614226;6449.709763060768;6469.45009674183;6482.805515834532;6530.444912182517;6537.248216454978;6050.273967123797;6079.088136779518;6126.877462450815;6203.689815509116;6246.46905013079;6282.968585157045;6288.402601752826;6304.747810087545;6344.1118243445035;6352.618842869442 15:22:02 INFO - PROCESS | 7708 | |4;prototype.html;302.27303335478183;303.86781749938774;305.31304564729356;314.7434840604905;315.07839569259926;5177.197534382168;5265.815696450621;5295.735213239337;5362.490563396481;5383.946160538393;5238.214267859823;5278.47215278472;5300.575953923687;5300.628955973083;5312.92030619541;3833.5974722654137;3976.045749020229;4084.36692312692;4095.610916962891;4098.036961314089;4067.613576710223;4077.755334679914;4090.365993271033;4090.468239128924;4094.8362065517495;4026.4699414222555;4035.656969157625;4037.6164264394833;4050.9594904051023;4051.230266249403;3808.7714737115584;3898.1229223424502;4006.699497537667;4013.2776100301935;4048.8785336439955;3477.374072666919;3478.4956181353564;3482.9129271768156;3490.249596336774;3495.493153492729;5046.873828154289;5108.846734597968;5109.642325037249;5114.079465696173;5114.718690472023;4595.2188128018315;4602;4604.447466304065;4607.470140933769;4607.746573938432;5463.945360546383;5493.066178749622;5498.615096943216;5499.395066542677;5499.587530935196;3753.2118255166447;3753.9436908446396;3754.19284853755;3756.793376364299;3762.7177961652988;5588.580856435784;5673.290838645169;5738.569607279471;5749.540036797088;5756.338021127582;3825.2540754552597;3849.7882616456363;3863.1887303666545;3863.5363756349416;3870.59358767331;3923.2741942740686;3931.410288456754;3931.9606803932165;3933.7639741615594;3941.349677303213;4543.54564543543;4552.772361381918;4554.63562914966;4557.453105627346;4562.589366956923;5551.361593416728;5551.9722401387735;5558.722063896789;5560.4161563035295;5560.972195138998;1376.2843321472978;1409.6405416618697;1409.978850317246;1410.781328894023;1412.8445870954188;875.9737207883774;905.8143080668447;922.9953850230706;959.0744931141481;962.2302158273353;4769.856904292877;4838.661293709477;4849.75751212438;4927.063857866994;4930.827421040318;5839.620424672383;5896.970515147397;5897.5871688982215;5900.085486749561;5900.852478688067;4908.631852611068;4912.38595175603;4914.778834952364;4918.508149185053;4921.311016457699;3070.309180434429;3112.299732560156;3118.501039833616;3120.937581248362;3121.3133110715607;5498.697571633518;5501.889962200734;5505.339359276913;5515.310586176728;5516.227728118067;5784.219130417424;5952.345242023374;5956.910646340309;5964.463198312173;5975.073863551156;5455.208994695747;5486.91769623448;5500.834974950758;5507.642003269774;5508.944910550923;5790.739416726342;5792.044312688359;5799.652020878761;5801.3908539602735;5806.912896306474;5640.210370548209;5658.632188907708;5702.714864256687;5709.000924838219;5718.399568045295;5483.424240454695;5484.506394424521;5485.753141108739;5489.615726899079;5502.119660854244;3766.0961369271727;3898.7270891037356;3940.842366305316;3950;3960.0495880988933;5712.828615141552;5739.196512488172;5741.8564535886935;5745.8563535911935;5748.367679555329;5531.612787104864;5536.584756143386;5537.280153580009;5537.390887002346;5537.861553461195;5470;5525.9447405527035;5528.06022976087;5528.391876893458;5541.058020136506;5418;5420.430854760193;5423.078076726887;5436.782528698808;5440.347158341025;5405.945940540544;5562.666240025612;5572.498475137095;5582;5582.916256256078;5372.274742909657;5428.67427954324;5435.864103397446;5438.646487978269;5442.918356224739 15:22:02 INFO - PROCESS | 7708 | |5;yui.html;711.5695004522265;729.3472342253687;747.3834086878323;749.1123019222222;751.4364226829881;11372.37451940143;11507.482163302651;11509.769804603913;11515.827262591069;11542.538298468051;11328.830067548994;11351.659450216486;11397.373144477051;11398;11409.714757131076;611.3153268339466;776.227653484782;778.9182135875736;802.5305196460077;803.5459965119718;780.3094261578516;791.5053091817614;797.1589972578927;798.4171554765026;800.9759707208764;815.1888870573788;843.7510934274404;850.1328644782318;850.6427300533791;850.9234168924795;642.0369445831253;815.0667485728837;825.793551612097;826.404988408345;827.5407149032285;589.4753669234385;595.1905408644241;615.9846003849894;616.1097214525013;616.5037145098194;10815;10842.241043126984;10936.671899843017;10951.671449856518;10973;11150.776984460266;11526.481308341145;11881;12061.457234424384;12372.690682732913;9037.461107654013;9264.72205833826;9313.348065635408;9348.1119293667;9415.482148481831;3006.615149287832;3057.2815388383933;3070.4473194824923;3084.15185823898;3137.8117312961294;41572.37641435381;41624.583754162675;41817;41857.58142418567;41869.79065104655;8733.650653973897;9379;9422.811543769087;9666.468344240993;9693.369930954465;17010.48968530946;17023.744643830352;17147.657046858993;17155.056471894164;17182.570435738955;6437.2918978912285;6456.160699109086;6506.967465162644;6529.118568993125;6762.797116086525;3234.1267857678295;3270.133414645121;3271.378438096754;3337.7162941150273;3356.9664303357144;2570.383108054091;2607.113581382339;2607.843529388205;2608.595667671514;2609.0737788084957;470.8658032460732;474.65350294285366;479.9208130658402;481.1699817814312;483.98604922686917;491.263105341987;492.2173743747459;552.4116815591383;568.6701713006529;611.4252602553674;7415.1472580652835;7550.282723141293;7868.842623147505;8002.279794818494;8139.75580732579;588.9823305300848;599.2030599302917;600.1148306248336;612.8712920540576;631.3780925788095;3317.353116142329;3674.356987527172;3720.069982504374;3720.609336019679;3792.3173828710546;41868.79065604713;42058.158836823095;42682.57317426848;42730.57269427328;42854.35718464226;37406.43890341647;38094.428583571265;38096.80951595224;38486.23027539434;38677.6132238674;37976.99999999945;40296.395554066716;40842.59157408447;41871.58128418738;42004.36993445101;8093.838123237385;8122.147174546588;8143.144969778088;8160.877586836321;8355.665773368997;29185.41629167447;29373.853130735064;29500.11499655014;31465.528017079305;31874.043778686675;35669.28661426809;39792.801035994635;40219.1956160881;41279.38080928849;41471.170576588906;10272.280940334105;10386.636467723594;10422.530986105492;10512.369257844553;10534.104601108686;10577.153827693919;10752.193585481276;11112;11153.219274650697;11201.991820735846;8294.460860044077;8876.733697989072;10662.626808061681;10897.727556811144;11334.14993875446;9746.561404736945;10212.489375531046;11267.774644507228;11364.886351136383;11696.239744416585;10224.53989570486;10873.836892446778;10883.782324353628;10891;11037.724056898642;8688.26149777276;8776.341774367076;8799.296056315607;8956.238719708897;9055.456672599665;8768.561571921506;9022.548872556477;9346.485943272914;9382.530873456437;9458.43249405038 15:22:02 INFO - PROCESS | 7708 | __end_tp_report 15:22:02 INFO - PROCESS | 7708 | __start_cc_report 15:22:02 INFO - PROCESS | 7708 | _x_x_mozilla_cycle_collect,1080 15:22:02 INFO - PROCESS | 7708 | __end_cc_report 15:22:02 INFO - PROCESS | 7708 | __startTimestamp1457565722711__endTimestamp 15:22:02 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | ------- Summary: start ------- 15:22:02 INFO - PROCESS | 7708 | Number of tests: 6 15:22:02 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | [#0] dojo.html Cycles:165 Average:4517.51 Median:4631.10 stddev:466.90 (10.1%) stddev-sans-first:442.92 15:22:02 INFO - PROCESS | 7708 | Values: 2580.5 2667.3 2678.8 2686.0 2713.2 4449.6 4526.2 4595.0 4603.4 4634.5 4503.6 4568.5 4581.4 4598.2 4611.7 4200.0 4210.6 4231.2 4251.0 4310.6 4229.1 4281.7 4285.4 4299.7 4316.9 4059.1 4136.5 4230.7 4242.9 4310.8 4177.8 4206.5 4223.2 4236.8 4257.9 4167.3 4173.4 4182.0 4194.8 4209.0 4343.3 4480.8 4483.5 4483.8 4514.1 4898.1 4903.5 4905.6 4932.0 4952.7 4918.3 4924.7 4925.9 4929.5 4957.4 4444.9 4554.3 4568.2 4577.9 4617.8 4979.3 4998.3 5001.9 5004.7 5034.8 4790.1 4802.9 4805.8 4807.0 4840.6 4777.2 4867.7 4918.2 4937.8 4945.2 4852.7 4863.8 4872.9 4884.2 4927.7 4861.0 4866.8 4880.4 4888.5 4934.1 3969.1 4007.5 4034.1 4075.1 4075.6 3590.8 3591.2 3602.3 3636.9 3639.0 4213.7 4221.0 4221.7 4224.3 4259.4 4746.5 4863.2 4899.4 4943.9 4950.8 4152.3 4171.9 4187.0 4188.6 4221.1 4246.5 4309.7 4310.5 4336.8 4345.7 4585.1 4618.0 4633.9 4660.8 4666.7 4864.4 4870.7 4882.0 4889.8 4911.1 4597.6 4639.6 4643.2 4674.1 4690.4 4906.6 4920.8 4922.0 4953.8 4968.6 4974.3 4976.4 4983.2 4988.5 5028.7 4651.6 4707.6 4776.6 4826.6 4875.6 4679.8 4690.0 4695.1 4731.4 4741.9 4625.3 4625.7 4628.9 4631.1 4672.7 4654.4 4666.4 4738.1 4748.1 4812.5 4601.8 4609.1 4663.4 4674.6 4692.4 15:22:02 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | [#1] ext.html Cycles:180 Average:35941.36 Median:32969.68 stddev:55827.95 (169.3%) stddev-sans-first:55921.12 15:22:02 INFO - PROCESS | 7708 | Values: 495.0 500.5 509.7 515.3 539.9 25602.2 34356.5 34790.0 34852.3 34922.8 38245.6 38593.0 38710.4 38711.6 38839.6 7532.3 7726.4 7731.5 7732.2 7734.2 7686.3 7813.8 7830.2 7832.9 7835.0 7802.3 8061.6 8080.7 8085.1 8088.7 7902.8 7975.2 7979.6 8000.9 8002.7 7778.3 7825.7 7897.8 7915.5 7916.9 37858.6 38263.8 38324.6 38332.8 38377.0 2835.1 2891.7 2896.5 3002.3 3206.8 28973.0 29125.7 29266.1 29790.4 30530.4 3455.6 3512.5 3526.1 3526.5 3591.0 181239.0 181686.0 182383.0 182778.0 182982.0 38469.6 39612.8 52575.2 53005.0 53089.5 36843.6 36844.8 36882.4 36930.8 37043.6 11236.4 11409.0 11413.4 11417.9 11420.5 8785.4 8924.6 8935.7 8944.9 8948.9 12914.8 13377.7 13388.3 13425.2 13513.1 5264.3 5313.2 5326.2 5393.5 5396.5 729.3 759.3 867.2 927.6 1017.6 25609.0 25963.2 26323.7 26410.9 26437.7 725.5 902.6 929.6 1027.1 1031.1 12099.6 12286.3 12309.1 12495.3 12518.6 262990.0 266602.0 267567.0 267932.0 268199.0 42837.8 43229.4 43381.8 43437.8 43440.1 1102.7 1124.4 1153.9 1157.6 1211.1 23816.9 25942.4 26509.2 26915.7 26963.7 32961.2 32978.2 33140.8 33170.7 33177.2 182205.0 183299.0 183390.0 183521.0 184112.0 24350.4 28149.0 29201.6 29552.4 29690.7 32896.8 33639.7 34040.0 34184.5 37126.3 31516.4 31744.2 31862.7 31883.8 31906.4 31803.8 31979.5 32120.7 32339.2 32395.0 32189.6 32535.5 32814.7 32826.5 32857.2 26580.8 29258.0 29273.6 29303.7 29356.3 20912.6 21119.3 21259.9 21267.7 21313.0 15:22:02 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | [#2] jquery.html Cycles:180 Average:22075.99 Median:5089.04 stddev:60560.59 (1190.0%) stddev-sans-first:60708.46 15:22:02 INFO - PROCESS | 7708 | Values: 329.0 333.1 339.4 345.2 350.6 14581.7 15029.7 15210.2 15403.3 15738.5 14179.9 14663.0 14906.5 15511.8 15530.5 5019.7 5148.9 5189.5 5193.6 5205.7 5013.4 5142.1 5222.9 5230.2 5233.9 5187.7 5194.5 5209.5 5210.0 5215.7 5033.9 5159.0 5166.0 5269.3 5273.5 5064.5 5085.5 5085.7 5092.4 5113.2 10982.0 11876.8 18949.5 18951.4 18959.6 1658.9 1672.5 1690.2 1716.8 1759.5 8761.1 8992.1 9071.2 9239.3 11929.8 1702.5 1741.4 1759.9 1813.7 1858.1 52392.2 58120.7 58567.1 58686.7 60389.0 9729.0 9812.3 9883.8 9928.7 9999.6 12559.4 12765.7 12766.4 12768.7 12771.4 6591.3 6646.0 6692.1 6798.1 6802.3 6163.1 6216.4 6319.3 6338.7 6352.7 4046.6 4069.0 4217.7 4348.5 4358.8 1607.7 1660.5 1686.9 1711.9 1721.9 715.5 810.1 829.4 921.7 942.9 15316.9 15357.9 15481.8 15892.4 16019.6 789.8 806.0 815.7 839.9 843.0 8688.1 8878.3 9119.8 9207.4 9258.8 275965.0 375894.0 391724.0 393705.0 394642.0 60065.0 60632.7 60938.0 62660.4 62784.4 903.3 909.4 932.6 932.8 947.6 14215.9 14538.8 14541.8 14680.9 14762.9 30786.0 31062.7 31486.8 31721.0 32223.4 41947.0 44267.0 44409.6 44834.8 44836.8 6920.0 7250.2 7423.4 7429.4 7443.4 8199.6 10558.2 11075.2 11361.9 11376.7 9275.5 9533.0 9619.8 9942.0 9952.9 9502.3 9687.5 9821.9 9888.6 10123.8 10440.8 10450.7 10461.8 10463.3 10671.9 7285.5 7368.6 7423.2 7452.1 7457.5 9153.4 10200.3 10242.6 10273.4 10471.6 15:22:02 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | [#3] mootools.html Cycles:180 Average:5250.64 Median:6225.08 stddev:2785.56 (44.7%) stddev-sans-first:2776.93 15:22:02 INFO - PROCESS | 7708 | Values: 1223.3 1337.3 1344.9 1456.8 1725.8 7182.6 7318.6 7328.5 7330.5 7352.0 7167.9 7300.2 7319.7 7327.0 7333.6 1803.9 2154.2 2190.6 2195.8 2208.9 2223.2 2240.1 2243.5 2243.6 2244.5 2099.6 2189.3 2191.6 2193.0 2196.2 2148.3 2178.4 2189.5 2214.0 2224.3 2188.8 2201.0 2203.3 2207.4 2210.6 7402.8 7448.0 7448.1 7470.0 7480.9 4503.6 4622.4 4635.3 4668.3 4669.9 2927.0 2952.4 3012.1 3018.0 3046.6 908.5 910.2 921.4 945.3 947.9 10544.4 10547.3 10595.5 10616.6 10628.3 4273.5 4387.1 4444.2 4455.0 4460.3 8896.2 8899.7 8933.4 8937.2 8948.0 3818.9 4691.3 4704.7 4710.0 4731.5 4047.0 4108.3 4110.4 4117.8 4133.0 3514.1 3606.7 3607.7 3629.8 3648.1 1075.2 1078.4 1083.0 1083.7 1130.0 1133.6 1143.3 1152.1 1169.7 1206.7 7167.3 7226.5 7234.3 7263.4 7284.7 431.8 436.5 436.9 437.3 437.9 5259.8 5297.1 5313.9 5325.4 5603.2 9029.8 9325.0 9395.2 9442.7 9457.9 9077.1 9086.0 9260.6 9274.2 9306.2 6965.5 7033.2 7086.0 7121.8 7133.3 6743.7 6796.0 6848.9 6851.1 6935.8 8194.7 8269.2 8382.7 8408.6 8455.7 8408.9 8507.4 8648.8 8649.9 8664.6 5684.5 6180.0 6399.3 6603.3 6707.1 7132.0 7134.0 7140.5 7166.4 7203.3 6316.7 6486.5 6551.5 6553.6 6632.3 6260.4 6367.7 6391.0 6430.0 6535.9 6449.7 6469.5 6482.8 6530.4 6537.2 6050.3 6079.1 6126.9 6203.7 6246.5 6283.0 6288.4 6304.7 6344.1 6352.6 15:22:02 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | [#4] prototype.html Cycles:180 Average:4586.45 Median:5300.60 stddev:1369.96 (25.8%) stddev-sans-first:1335.53 15:22:02 INFO - PROCESS | 7708 | Values: 302.3 303.9 305.3 314.7 315.1 5177.2 5265.8 5295.7 5362.5 5383.9 5238.2 5278.5 5300.6 5300.6 5312.9 3833.6 3976.0 4084.4 4095.6 4098.0 4067.6 4077.8 4090.4 4090.5 4094.8 4026.5 4035.7 4037.6 4051.0 4051.2 3808.8 3898.1 4006.7 4013.3 4048.9 3477.4 3478.5 3482.9 3490.2 3495.5 5046.9 5108.8 5109.6 5114.1 5114.7 4595.2 4602.0 4604.4 4607.5 4607.7 5463.9 5493.1 5498.6 5499.4 5499.6 3753.2 3753.9 3754.2 3756.8 3762.7 5588.6 5673.3 5738.6 5749.5 5756.3 3825.3 3849.8 3863.2 3863.5 3870.6 3923.3 3931.4 3932.0 3933.8 3941.3 4543.5 4552.8 4554.6 4557.5 4562.6 5551.4 5552.0 5558.7 5560.4 5561.0 1376.3 1409.6 1410.0 1410.8 1412.8 876.0 905.8 923.0 959.1 962.2 4769.9 4838.7 4849.8 4927.1 4930.8 5839.6 5897.0 5897.6 5900.1 5900.9 4908.6 4912.4 4914.8 4918.5 4921.3 3070.3 3112.3 3118.5 3120.9 3121.3 5498.7 5501.9 5505.3 5515.3 5516.2 5784.2 5952.3 5956.9 5964.5 5975.1 5455.2 5486.9 5500.8 5507.6 5508.9 5790.7 5792.0 5799.7 5801.4 5806.9 5640.2 5658.6 5702.7 5709.0 5718.4 5483.4 5484.5 5485.8 5489.6 5502.1 3766.1 3898.7 3940.8 3950.0 3960.0 5712.8 5739.2 5741.9 5745.9 5748.4 5531.6 5536.6 5537.3 5537.4 5537.9 5470.0 5525.9 5528.1 5528.4 5541.1 5418.0 5420.4 5423.1 5436.8 5440.3 5405.9 5562.7 5572.5 5582.0 5582.9 5372.3 5428.7 5435.9 5438.6 5442.9 15:22:02 INFO - PROCESS | 7708 | 15:22:02 INFO - PROCESS | 7708 | [#5] yui.html Cycles:180 Average:11849.72 Median:41870.69 stddev:12970.67 (31.0%) stddev-sans-first:12980.09 15:22:02 INFO - PROCESS | 7708 | Values: 711.6 729.3 747.4 749.1 751.4 11372.4 11507.5 11509.8 11515.8 11542.5 11328.8 11351.7 11397.4 11398.0 11409.7 611.3 776.2 778.9 802.5 803.5 780.3 791.5 797.2 798.4 801.0 815.2 843.8 850.1 850.6 850.9 642.0 815.1 825.8 826.4 827.5 589.5 595.2 616.0 616.1 616.5 10815.0 10842.2 10936.7 10951.7 10973.0 11150.8 11526.5 11881.0 12061.5 12372.7 9037.5 9264.7 9313.3 9348.1 9415.5 3006.6 3057.3 3070.4 3084.2 3137.8 41572.4 41624.6 41817.0 41857.6 41869.8 8733.7 9379.0 9422.8 9666.5 9693.4 17010.5 17023.7 17147.7 17155.1 17182.6 6437.3 6456.2 6507.0 6529.1 6762.8 3234.1 3270.1 3271.4 3337.7 3357.0 2570.4 2607.1 2607.8 2608.6 2609.1 470.9 474.7 479.9 481.2 484.0 491.3 492.2 552.4 568.7 611.4 7415.1 7550.3 7868.8 8002.3 8139.8 589.0 599.2 600.1 612.9 631.4 3317.4 3674.4 3720.1 3720.6 3792.3 41868.8 42058.2 42682.6 42730.6 42854.4 37406.4 38094.4 38096.8 38486.2 38677.6 37977.0 40296.4 40842.6 41871.6 42004.4 8093.8 8122.1 8143.1 8160.9 8355.7 29185.4 29373.9 29500.1 31465.5 31874.0 35669.3 39792.8 40219.2 41279.4 41471.2 10272.3 10386.6 10422.5 10512.4 10534.1 10577.2 10752.2 11112.0 11153.2 11202.0 8294.5 8876.7 10662.6 10897.7 11334.1 9746.6 10212.5 11267.8 11364.9 11696.2 10224.5 10873.8 10883.8 10891.0 11037.7 8688.3 8776.3 8799.3 8956.2 9055.5 8768.6 9022.5 9346.5 9382.5 9458.4 15:22:02 INFO - PROCESS | 7708 | -------- Summary: end -------- 15:22:02 INFO - PROCESS | 7708 | 15:22:03 INFO - TEST-INFO | 7708: exit 0 15:22:03 INFO - TEST-OK | dromaeo_css | took 1116749ms 15:22:03 INFO - TEST-START | kraken 15:22:03 INFO - operating with platform_type : linux_ 15:22:03 INFO - Initialising browser for kraken test... 15:22:03 INFO - TEST-INFO | started process 7887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxD4qV6/profile http://localhost:37819/getInfo.html) 15:22:07 INFO - PROCESS | 7887 | __metrics Screen width/height:1600/1200 15:22:07 INFO - PROCESS | 7887 | colorDepth:24 15:22:07 INFO - PROCESS | 7887 | Browser inner width/height: 1024/697 15:22:07 INFO - PROCESS | 7887 | __metrics 15:22:08 ERROR - PROCESS | 7887 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:22:09 INFO - TEST-INFO | 7887: exit 0 15:22:09 INFO - Browser initialized. 15:22:09 INFO - Running cycle 1/1 for kraken test... 15:22:09 INFO - TEST-INFO | started process 7971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxD4qV6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:21 INFO - PROCESS | 7971 | RSS: Main: 154132480 15:22:21 INFO - PROCESS | 7971 | 15:22:24 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37819/tests/kraken/driver.html?testName=audio-beat-detection) 15:22:24 INFO - PROCESS | 7971 | RSS: Main: 194514944 15:22:24 INFO - PROCESS | 7971 | 15:22:27 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37819/tests/kraken/driver.html?testName=audio-dft) 15:22:28 INFO - PROCESS | 7971 | RSS: Main: 185147392 15:22:28 INFO - PROCESS | 7971 | 15:22:31 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37819/tests/kraken/driver.html?testName=audio-fft) 15:22:31 INFO - PROCESS | 7971 | RSS: Main: 171237376 15:22:31 INFO - PROCESS | 7971 | 15:22:33 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37819/tests/kraken/driver.html?testName=audio-oscillator) 15:22:34 INFO - PROCESS | 7971 | RSS: Main: 173711360 15:22:34 INFO - PROCESS | 7971 | 15:22:36 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37819/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:22:37 INFO - PROCESS | 7971 | RSS: Main: 174448640 15:22:37 INFO - PROCESS | 7971 | 15:22:40 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37819/tests/kraken/driver.html?testName=imaging-darkroom) 15:22:40 INFO - PROCESS | 7971 | RSS: Main: 174333952 15:22:40 INFO - PROCESS | 7971 | 15:22:44 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37819/tests/kraken/driver.html?testName=imaging-desaturate) 15:22:45 INFO - PROCESS | 7971 | RSS: Main: 172519424 15:22:45 INFO - PROCESS | 7971 | 15:22:47 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37819/tests/kraken/driver.html?testName=json-parse-financial) 15:22:48 INFO - PROCESS | 7971 | RSS: Main: 173010944 15:22:48 INFO - PROCESS | 7971 | 15:22:50 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37819/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:22:50 INFO - PROCESS | 7971 | RSS: Main: 183816192 15:22:50 INFO - PROCESS | 7971 | 15:22:52 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37819/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:22:53 INFO - PROCESS | 7971 | RSS: Main: 182915072 15:22:53 INFO - PROCESS | 7971 | 15:22:55 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37819/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:22:56 INFO - PROCESS | 7971 | RSS: Main: 193724416 15:22:56 INFO - PROCESS | 7971 | 15:22:58 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:22:59 INFO - PROCESS | 7971 | RSS: Main: 198066176 15:22:59 INFO - PROCESS | 7971 | 15:23:01 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:23:02 INFO - PROCESS | 7971 | RSS: Main: 197771264 15:23:02 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | Cycle 1(1): loaded http://localhost:37819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37819/tests/kraken/driver.html?testName=ai-astar) 15:23:04 INFO - PROCESS | 7971 | RSS: Main: 258174976 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | __start_tp_report 15:23:04 INFO - PROCESS | 7971 | _x_x_mozilla_page_load 15:23:04 INFO - PROCESS | 7971 | _x_x_mozilla_page_load_details 15:23:04 INFO - PROCESS | 7971 | |i|pagename|runs| 15:23:04 INFO - PROCESS | 7971 | |0;ai-astar;111;114;106;113;114;113;101;113;112;113 15:23:04 INFO - PROCESS | 7971 | |1;audio-beat-detection;155;139;159;175;132;157;161;139;187;143 15:23:04 INFO - PROCESS | 7971 | |2;audio-dft;162;161;160;160;160;163;163;163;161;161 15:23:04 INFO - PROCESS | 7971 | |3;audio-fft;73;73;104;92;74;74;75;116;92;73 15:23:04 INFO - PROCESS | 7971 | |4;audio-oscillator;95;96;146;95;96;95;145;95;97;148 15:23:04 INFO - PROCESS | 7971 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;117;117 15:23:04 INFO - PROCESS | 7971 | |6;imaging-darkroom;148;146;147;147;146;147;146;146;146;146 15:23:04 INFO - PROCESS | 7971 | |7;imaging-desaturate;96;96;96;96;96;96;96;97;95;95 15:23:04 INFO - PROCESS | 7971 | |8;json-parse-financial;69;69;69;68;68;69;67;76;66;66 15:23:04 INFO - PROCESS | 7971 | |9;json-stringify-tinderbox;70;70;71;69;70;78;71;71;70;71 15:23:04 INFO - PROCESS | 7971 | |10;stanford-crypto-aes;84;84;91;82;83;90;92;84;84;82 15:23:04 INFO - PROCESS | 7971 | |11;stanford-crypto-ccm;131;124;120;119;129;122;128;134;122;136 15:23:04 INFO - PROCESS | 7971 | |12;stanford-crypto-pbkdf2;143;139;151;152;148;138;150;154;147;154 15:23:04 INFO - PROCESS | 7971 | |13;stanford-crypto-sha256-iterative;72;73;69;69;71;73;70;71;72;70 15:23:04 INFO - PROCESS | 7971 | __end_tp_report 15:23:04 INFO - PROCESS | 7971 | __start_cc_report 15:23:04 INFO - PROCESS | 7971 | _x_x_mozilla_cycle_collect,1140 15:23:04 INFO - PROCESS | 7971 | __end_cc_report 15:23:04 INFO - PROCESS | 7971 | __startTimestamp1457565784623__endTimestamp 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | ------- Summary: start ------- 15:23:04 INFO - PROCESS | 7971 | Number of tests: 14 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:4.22 (3.7%) stddev-sans-first:4.47 15:23:04 INFO - PROCESS | 7971 | Values: 111.0 114.0 106.0 113.0 114.0 113.0 101.0 113.0 112.0 113.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:158.00 stddev:17.20 (10.9%) stddev-sans-first:18.25 15:23:04 INFO - PROCESS | 7971 | Values: 155.0 139.0 159.0 175.0 132.0 157.0 161.0 139.0 187.0 143.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.26 (0.8%) stddev-sans-first:1.32 15:23:04 INFO - PROCESS | 7971 | Values: 162.0 161.0 160.0 160.0 160.0 163.0 163.0 163.0 161.0 161.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#3] audio-fft Cycles:10 Average:84.60 Median:74.00 stddev:15.61 (21.1%) stddev-sans-first:15.98 15:23:04 INFO - PROCESS | 7971 | Values: 73.0 73.0 104.0 92.0 74.0 74.0 75.0 116.0 92.0 73.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:95.00 stddev:24.54 (25.8%) stddev-sans-first:25.35 15:23:04 INFO - PROCESS | 7971 | Values: 95.0 96.0 146.0 95.0 96.0 95.0 145.0 95.0 97.0 148.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:23:04 INFO - PROCESS | 7971 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 15:23:04 INFO - PROCESS | 7971 | Values: 148.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 15:23:04 INFO - PROCESS | 7971 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 95.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:69.00 stddev:2.83 (4.1%) stddev-sans-first:3.00 15:23:04 INFO - PROCESS | 7971 | Values: 69.0 69.0 69.0 68.0 68.0 69.0 67.0 76.0 66.0 66.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:2.51 (3.5%) stddev-sans-first:2.64 15:23:04 INFO - PROCESS | 7971 | Values: 70.0 70.0 71.0 69.0 70.0 78.0 71.0 71.0 70.0 71.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.00 stddev:3.84 (4.6%) stddev-sans-first:4.02 15:23:04 INFO - PROCESS | 7971 | Values: 84.0 84.0 91.0 82.0 83.0 90.0 92.0 84.0 84.0 82.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:128.50 stddev:5.97 (4.6%) stddev-sans-first:6.10 15:23:04 INFO - PROCESS | 7971 | Values: 131.0 124.0 120.0 119.0 129.0 122.0 128.0 134.0 122.0 136.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.50 stddev:5.83 (3.9%) stddev-sans-first:5.95 15:23:04 INFO - PROCESS | 7971 | Values: 143.0 139.0 151.0 152.0 148.0 138.0 150.0 154.0 147.0 154.0 15:23:04 INFO - PROCESS | 7971 | 15:23:04 INFO - PROCESS | 7971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.50 stddev:1.49 (2.1%) stddev-sans-first:1.54 15:23:04 INFO - PROCESS | 7971 | Values: 72.0 73.0 69.0 69.0 71.0 73.0 70.0 71.0 72.0 70.0 15:23:04 INFO - PROCESS | 7971 | -------- Summary: end -------- 15:23:04 INFO - PROCESS | 7971 | 15:23:05 INFO - TEST-INFO | 7971: exit 0 15:23:05 INFO - TEST-OK | kraken | took 62143ms 15:23:05 INFO - SUITE-END | took 1178s 15:23:05 INFO - Completed test suite (00:19:39) 15:23:05 INFO - javascript benchmark 15:23:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2580.53550360935, 2667.3198334424733, 2678.825876318038, 2685.9731402685966, 2713.199606116195, 4449.621782148522, 4526.162659907911, 4594.954050459494, 4603.355530225767, 4634.490206077328, 4503.594676479124, 4568.543145685429, 4581.40441742573, 4598.218302888508, 4611.723296602207, 4200.0339921818, 4210.55789142141, 4231.196072746168, 4250.957490425087, 4310.633596144332, 4229.069604686964, 4281.721688090264, 4285.400043993844, 4299.656027517807, 4316.913661726763, 4059.0867054912705, 4136.482939632546, 4230.725002874803, 4242.91514169718, 4310.836074259948, 4177.770222637754, 4206.537280899099, 4223.176480586287, 4236.830526778926, 4257.936130958038, 4167.312393455076, 4173.373993900909, 4182.0, 4194.832206711728, 4209.031922657806, 4343.326784348431, 4480.798364073592, 4483.461984561841, 4483.843065492725, 4514.074614704011, 4898.093852637274, 4903.509649035068, 4905.607551395879, 4931.950680493185, 4952.67807592509, 4918.336024636664, 4924.679895806761, 4925.926111108336, 4929.507049295078, 4957.355543779286, 4444.933326000112, 4554.294084416921, 4568.200564901163, 4577.908441831178, 4617.769111544477, 4979.278004689372, 4998.2502624606595, 5001.924971125436, 5004.674696144739, 5034.798608055637, 4790.089882922233, 4802.8799280018275, 4805.783739731721, 4807.0, 4840.636952228527, 4777.235642297216, 4867.659263851497, 4918.188498897642, 4937.753112344369, 4945.23348880924, 4852.733099679552, 4863.829765958175, 4872.926906096412, 4884.242942343943, 4927.679700819435, 4861.0, 4866.7566621668775, 4880.41435027799, 4888.511148885154, 4934.136526107988, 3969.126792105732, 4007.5391329997424, 4034.092329225901, 4075.1238483726142, 4075.612816782401, 3590.8204589770407, 3591.1919818040733, 3602.3155600435834, 3636.890893273206, 3638.9636103639154, 4213.705040647186, 4221.0, 4221.746695198237, 4224.302990006676, 4259.38238955356, 4746.525347465225, 4863.2461968394955, 4899.387576552931, 4943.8516844494725, 4950.752462376867, 4152.314868046798, 4171.853985110507, 4187.0, 4188.623023927861, 4221.113566151143, 4246.4691913510815, 4309.719868208556, 4310.52584215736, 4336.804843782037, 4345.739255644671, 4585.10590434862, 4617.9769101155625, 4633.86098417048, 4660.790264438041, 4666.650001249987, 4864.416270047617, 4870.683405578626, 4882.0, 4889.804407823647, 4911.066897289504, 4597.60920321763, 4639.559241872017, 4643.207709925902, 4674.11191873543, 4690.413698287714, 4906.607471402351, 4920.778564964514, 4921.966387058757, 4953.7523123844385, 4968.602511799119, 4974.32846565709, 4976.353074100344, 4983.202687569971, 4988.5260900214425, 5028.698278103326, 4651.5813576778255, 4707.646926480596, 4776.641751868554, 4826.613870890391, 4875.6099512038245, 4679.836205732783, 4690.038542098793, 4695.084458530554, 4731.4322281325085, 4741.9051618968115, 4625.283081122431, 4625.722456652612, 4628.930566041579, 4631.096936097429, 4672.696274742131, 4654.394928659252, 4666.3700400445505, 4738.052389522179, 4748.074125545486, 4812.51874812516, 4601.792919318706, 4609.124266389375, 4663.440387153563, 4674.579287864109, 4692.41344831896], "unit": "score", "name": "dojo.html", "value": 4488.965032338383}, {"lowerIsBetter": false, "replicates": [494.9925751113733, 500.46200334640247, 509.671262035987, 515.2580284390478, 539.935207775067, 25602.231933041992, 34356.48465273023, 34789.95630131097, 34852.3029539409, 34922.82538587304, 38245.617543824555, 38593.0, 38710.419343709866, 38711.61288387115, 38839.61160388403, 7532.322091011808, 7726.381889448859, 7731.45879788415, 7732.188120247378, 7734.226577342249, 7686.269804368604, 7813.843723125534, 7830.177831327714, 7832.921670783277, 7834.960825195866, 7802.297793198611, 8061.6372263248295, 8080.717174898879, 8085.07021692507, 8088.676452941875, 7902.841943161134, 7975.2423519765525, 7979.56112413817, 8000.919990800134, 8002.67989280431, 7778.299953004257, 7825.686972521093, 7897.842043159162, 7915.485493442965, 7916.881246781303, 37858.62141378606, 38263.808680956696, 38324.616753832386, 38332.80833595814, 38377.0, 2835.064428738511, 2891.7108289170915, 2896.493113705093, 3002.3094688221613, 3206.7594930380315, 28973.0, 29125.708742912513, 29266.122016339545, 29790.404191916256, 30530.38939221203, 3455.6371580984137, 3512.4731290306404, 3526.0655926179584, 3526.488659144435, 3590.964090359089, 181239.0, 181686.0, 182383.0, 182778.0, 182982.0, 38469.61530384716, 39612.80193599071, 52575.21137182946, 53005.0, 53089.469105309225, 36843.63156368402, 36844.81577592149, 36882.44676329857, 36930.815345923096, 37043.629563704555, 11236.438178091226, 11409.030232430336, 11413.429328533706, 11417.942910285561, 11420.543178272776, 8785.428947118417, 8924.598393072327, 8935.731928042169, 8944.8658270126, 8948.926128864578, 12914.806277905838, 13377.66555836112, 13388.330583470788, 13425.194488330731, 13513.121647092907, 5264.315638966987, 5313.229581710631, 5326.201069839555, 5393.514583687487, 5396.541293990055, 729.3326606155415, 759.2673070486896, 867.21786728274, 927.5640448988964, 1017.6082208349839, 25609.0, 25963.22110336693, 26323.73676263251, 26410.86794566015, 26437.73562264391, 725.4812808841598, 902.6163880350824, 929.5538141692026, 1027.0807627173638, 1031.1441503552035, 12099.637010889688, 12286.324252166216, 12309.076819238413, 12495.250284982749, 12518.561850335194, 262990.0, 266602.0, 267567.0, 267932.0, 268199.0, 42837.785811070746, 43229.35155972663, 43381.78309108497, 43437.782811085744, 43440.13119737588, 1102.7298311913632, 1124.42092322454, 1153.9019183369508, 1157.5890558851654, 1211.0856303490807, 23816.88091559531, 25942.35144121412, 26509.204723858315, 26915.730842691322, 26963.730362696122, 32961.175970600925, 32978.17554561155, 33140.83429582933, 33170.66829331676, 33177.17057073592, 182205.0, 183299.0, 183390.0, 183521.0, 184112.0, 24350.391240219134, 28149.0, 29201.561976570792, 29552.408951820413, 29690.703092968793, 32896.83551582227, 33639.66360336365, 34040.0, 34184.48723269103, 37126.25747485089, 31516.369672606877, 31744.206394840312, 31862.681373186897, 31883.840580797874, 31906.36187276195, 31803.840980794947, 31979.520307194944, 32120.678793212704, 32339.19152021218, 32395.0, 32189.55147018343, 32535.51196732098, 32814.67185328212, 32826.50760238551, 32857.17857053593, 26580.775218553932, 29257.97597084092, 29273.560896586994, 29303.706962930097, 29356.266093347836, 20912.581748365254, 21119.260825871635, 21259.8937005314, 21267.680984784933, 21313.0], "unit": "score", "name": "ext.html", "value": 15401.048139471433}, {"lowerIsBetter": false, "replicates": [328.9506574013898, 333.1022893302549, 339.44670187594215, 345.2370261721595, 350.59856464348337, 14581.708365832677, 15029.699406011901, 15210.16344101074, 15403.306851191695, 15738.527844164679, 14179.858201418008, 14663.0, 14906.47827326041, 15511.844881551182, 15530.53408397747, 5019.698818070919, 5148.922766158511, 5189.455107213745, 5193.558547523447, 5205.687658740488, 5013.448520662742, 5142.074426603229, 5222.895542089156, 5230.163173892178, 5233.947660523384, 5187.688738675692, 5194.532492075712, 5209.479052094779, 5209.973950130244, 5215.660982036175, 5033.949660503385, 5159.019786240602, 5166.018456493254, 5269.314989051399, 5273.499017593323, 5064.5441910228255, 5085.516875896784, 5085.720285384303, 5092.363454568179, 5113.181890897438, 10982.011618954333, 11876.821847672292, 18949.526261843428, 18951.431457056173, 18959.62080758377, 1658.8507034366844, 1672.5149706585198, 1690.2140504665267, 1716.7596536484903, 1759.498542915263, 8761.08008659088, 8992.14574615417, 9071.183593476619, 9239.307051971062, 11929.761404771943, 1702.5488245614922, 1741.4079213067491, 1759.876808623397, 1813.6644720726576, 1858.1452531835373, 52392.21411678828, 58120.709396452745, 58567.121493177634, 58686.70656646732, 60389.0, 9728.951355243178, 9812.313138080408, 9883.802323953481, 9928.652497162564, 9999.550020249106, 12559.372031398394, 12765.68085797844, 12766.361681915867, 12768.680782980315, 12771.425285862158, 6591.274959754423, 6645.966770166215, 6692.063111164441, 6798.082258895085, 6802.319768023257, 6163.075538669146, 6216.378362163748, 6319.33646967071, 6338.651374174372, 6352.7141278642575, 4046.5548789633117, 4069.0, 4217.725847819882, 4348.456442944632, 4358.8038538265855, 1607.686501132268, 1660.5101495058987, 1686.9325226990784, 1711.9400820971207, 1721.9052952087504, 715.5277516838861, 810.088650268448, 829.3986859526915, 921.6866265469772, 942.9104235097655, 15316.927815053063, 15357.9232103841, 15481.767773483407, 15892.364305427885, 16019.599510012344, 789.7709664197318, 806.028735373873, 815.6900377856376, 839.9118092600311, 842.9915700843036, 8688.131186881388, 8878.334124940526, 9119.81760364789, 9207.40151890125, 9258.768530786649, 275965.0, 375894.0, 391724.0, 393705.0, 394642.0, 60065.0, 60632.69683651553, 60938.0, 62660.37339626637, 62784.37215627785, 903.2864037410503, 909.4406939732149, 932.5710173320349, 932.7528205025674, 947.6020071569819, 14215.857841421453, 14538.781918271447, 14541.78187327212, 14680.926595366955, 14762.852371476578, 30786.0, 31062.68937310598, 31486.842565787025, 31721.0, 32223.35553288968, 41947.0, 44267.0, 44409.555904440545, 44834.77582612066, 44836.77581612071, 6919.965400172967, 7250.166230883516, 7423.406127509678, 7429.405647548075, 7443.36731377839, 8199.590020498832, 10558.208134390105, 11075.224734268524, 11361.943190283995, 11376.715582110513, 9275.536223188948, 9532.95233523828, 9619.759506012406, 9941.950290248502, 9952.850707239542, 9502.334836561375, 9687.515624218902, 9821.901780982385, 9888.604455821687, 10123.848142277724, 10440.791184176425, 10450.68647940563, 10461.843072354073, 10463.319884207502, 10671.94664026675, 7285.453590980804, 7368.6315684214505, 7423.220561841145, 7452.143003554661, 7457.47797654159, 9153.405028673114, 10200.271554650528, 10242.590296388062, 10273.434961076913, 10471.633492827714], "unit": "score", "name": "jquery.html", "value": 7652.067780584628}, {"lowerIsBetter": false, "replicates": [1223.3455101520688, 1337.2912356451081, 1344.932753362332, 1456.8470310617386, 1725.7842769653794, 7182.604956727378, 7318.5974771387555, 7328.523645963009, 7330.523515971458, 7352.04423424954, 7167.928320716791, 7300.1604815446235, 7319.7438089666875, 7326.96336518318, 7333.6333183340885, 1803.891766494008, 2154.192177933275, 2190.5728382965326, 2195.7584665686763, 2208.86746795192, 2223.2329846203115, 2240.1263507232193, 2243.5064285857084, 2243.5849367866917, 2244.5286489837154, 2099.622068027762, 2189.310367234324, 2191.616467118256, 2193.035064571591, 2196.2203417786695, 2148.291063948893, 2178.4227179797367, 2189.474526113729, 2213.9557208855895, 2224.277109939276, 2188.803007729312, 2200.9559808803892, 2203.294945617403, 2207.4371035386034, 2210.613142700021, 7402.777916662509, 7447.9627601862185, 7448.106227252711, 7469.962650186769, 7480.9251907480775, 4503.639708823286, 4622.422197225347, 4635.2583586626315, 4668.276417155346, 4669.929951050737, 2926.956095658567, 2952.3652414730723, 3012.0813151988636, 3018.0493144659363, 3046.57347971282, 908.5230254116576, 910.1808372464768, 921.3550514639712, 945.2910317262053, 947.9099485548862, 10544.420056896868, 10547.314424562379, 10595.470226488722, 10616.57533698651, 10628.256022078458, 4273.487181538173, 4387.122575484916, 4444.2222611042935, 4455.04216593434, 4460.286354183315, 8896.243819275305, 8899.688510902088, 8933.419327743675, 8937.240334571505, 8947.955260223658, 3818.9236215276096, 4691.319758635047, 4704.741239231875, 4709.95290047102, 4731.455882573479, 4046.979765101156, 4108.322126849036, 4110.383442483591, 4117.835286588503, 4133.028738246509, 3514.139035936212, 3606.693431058337, 3607.74745767799, 3629.8003609801713, 3648.1062139775927, 1075.1560025380195, 1078.379931539368, 1083.014456844268, 1083.6586475260267, 1130.0168853097693, 1133.6145710458484, 1143.3140115930375, 1152.09560495011, 1169.7485040716288, 1206.6561030106377, 7167.319104685047, 7226.530275532074, 7234.276572342724, 7263.418926485869, 7284.6721897514735, 431.83158568158444, 436.4893075102138, 436.9191699535596, 437.28285611597005, 437.8883384736935, 5259.8422047338645, 5297.125974214211, 5313.946860531422, 5325.3875804282225, 5603.2435621191435, 9029.819403611891, 9324.95337523308, 9395.20140788027, 9442.669506567374, 9457.90542094584, 9077.137671921157, 9086.0, 9260.629574816932, 9274.165325120637, 9306.208972237435, 6965.5124141309625, 7033.191183013917, 7086.0, 7121.82195445118, 7133.251008644018, 6743.730250789913, 6796.0, 6848.8972665409065, 6851.143607049119, 6935.791926242221, 8194.713185038496, 8269.21442462965, 8382.70660526903, 8408.579571021302, 8455.704050358208, 8408.87386689188, 8507.404481686222, 8648.78378040554, 8649.913500865163, 8664.566771661517, 5684.516816070515, 6179.969100154471, 6399.2640846303275, 6603.339666033358, 6707.061011458497, 7132.0, 7134.0, 7140.500164988401, 7166.390856777024, 7203.315685009916, 6316.715747791269, 6486.481081513373, 6551.508636852351, 6553.574017688835, 6632.336766323329, 6260.40526150015, 6367.681615919093, 6390.968045159744, 6429.9678501607195, 6535.869282614226, 6449.709763060768, 6469.45009674183, 6482.805515834532, 6530.444912182517, 6537.248216454978, 6050.273967123797, 6079.088136779518, 6126.877462450815, 6203.689815509116, 6246.46905013079, 6282.968585157045, 6288.402601752826, 6304.747810087545, 6344.1118243445035, 6352.618842869442], "unit": "score", "name": "mootools.html", "value": 4210.881046064981}, {"lowerIsBetter": false, "replicates": [302.27303335478183, 303.86781749938774, 305.31304564729356, 314.7434840604905, 315.07839569259926, 5177.197534382168, 5265.815696450621, 5295.735213239337, 5362.490563396481, 5383.946160538393, 5238.214267859823, 5278.47215278472, 5300.575953923687, 5300.628955973083, 5312.92030619541, 3833.5974722654137, 3976.045749020229, 4084.36692312692, 4095.610916962891, 4098.036961314089, 4067.613576710223, 4077.755334679914, 4090.365993271033, 4090.468239128924, 4094.8362065517495, 4026.4699414222555, 4035.656969157625, 4037.6164264394833, 4050.9594904051023, 4051.230266249403, 3808.7714737115584, 3898.1229223424502, 4006.699497537667, 4013.2776100301935, 4048.8785336439955, 3477.374072666919, 3478.4956181353564, 3482.9129271768156, 3490.249596336774, 3495.493153492729, 5046.873828154289, 5108.846734597968, 5109.642325037249, 5114.079465696173, 5114.718690472023, 4595.2188128018315, 4602.0, 4604.447466304065, 4607.470140933769, 4607.746573938432, 5463.945360546383, 5493.066178749622, 5498.615096943216, 5499.395066542677, 5499.587530935196, 3753.2118255166447, 3753.9436908446396, 3754.19284853755, 3756.793376364299, 3762.7177961652988, 5588.580856435784, 5673.290838645169, 5738.569607279471, 5749.540036797088, 5756.338021127582, 3825.2540754552597, 3849.7882616456363, 3863.1887303666545, 3863.5363756349416, 3870.59358767331, 3923.2741942740686, 3931.410288456754, 3931.9606803932165, 3933.7639741615594, 3941.349677303213, 4543.54564543543, 4552.772361381918, 4554.63562914966, 4557.453105627346, 4562.589366956923, 5551.361593416728, 5551.9722401387735, 5558.722063896789, 5560.4161563035295, 5560.972195138998, 1376.2843321472978, 1409.6405416618697, 1409.978850317246, 1410.781328894023, 1412.8445870954188, 875.9737207883774, 905.8143080668447, 922.9953850230706, 959.0744931141481, 962.2302158273353, 4769.856904292877, 4838.661293709477, 4849.75751212438, 4927.063857866994, 4930.827421040318, 5839.620424672383, 5896.970515147397, 5897.5871688982215, 5900.085486749561, 5900.852478688067, 4908.631852611068, 4912.38595175603, 4914.778834952364, 4918.508149185053, 4921.311016457699, 3070.309180434429, 3112.299732560156, 3118.501039833616, 3120.937581248362, 3121.3133110715607, 5498.697571633518, 5501.889962200734, 5505.339359276913, 5515.310586176728, 5516.227728118067, 5784.219130417424, 5952.345242023374, 5956.910646340309, 5964.463198312173, 5975.073863551156, 5455.208994695747, 5486.91769623448, 5500.834974950758, 5507.642003269774, 5508.944910550923, 5790.739416726342, 5792.044312688359, 5799.652020878761, 5801.3908539602735, 5806.912896306474, 5640.210370548209, 5658.632188907708, 5702.714864256687, 5709.000924838219, 5718.399568045295, 5483.424240454695, 5484.506394424521, 5485.753141108739, 5489.615726899079, 5502.119660854244, 3766.0961369271727, 3898.7270891037356, 3940.842366305316, 3950.0, 3960.0495880988933, 5712.828615141552, 5739.196512488172, 5741.8564535886935, 5745.8563535911935, 5748.367679555329, 5531.612787104864, 5536.584756143386, 5537.280153580009, 5537.390887002346, 5537.861553461195, 5470.0, 5525.9447405527035, 5528.06022976087, 5528.391876893458, 5541.058020136506, 5418.0, 5420.430854760193, 5423.078076726887, 5436.782528698808, 5440.347158341025, 5405.945940540544, 5562.666240025612, 5572.498475137095, 5582.0, 5582.916256256078, 5372.274742909657, 5428.67427954324, 5435.864103397446, 5438.646487978269, 5442.918356224739], "unit": "score", "name": "prototype.html", "value": 4146.457789313708}, {"lowerIsBetter": false, "replicates": [711.5695004522265, 729.3472342253687, 747.3834086878323, 749.1123019222222, 751.4364226829881, 11372.37451940143, 11507.482163302651, 11509.769804603913, 11515.827262591069, 11542.538298468051, 11328.830067548994, 11351.659450216486, 11397.373144477051, 11398.0, 11409.714757131076, 611.3153268339466, 776.227653484782, 778.9182135875736, 802.5305196460077, 803.5459965119718, 780.3094261578516, 791.5053091817614, 797.1589972578927, 798.4171554765026, 800.9759707208764, 815.1888870573788, 843.7510934274404, 850.1328644782318, 850.6427300533791, 850.9234168924795, 642.0369445831253, 815.0667485728837, 825.793551612097, 826.404988408345, 827.5407149032285, 589.4753669234385, 595.1905408644241, 615.9846003849894, 616.1097214525013, 616.5037145098194, 10815.0, 10842.241043126984, 10936.671899843017, 10951.671449856518, 10973.0, 11150.776984460266, 11526.481308341145, 11881.0, 12061.457234424384, 12372.690682732913, 9037.461107654013, 9264.72205833826, 9313.348065635408, 9348.1119293667, 9415.482148481831, 3006.615149287832, 3057.2815388383933, 3070.4473194824923, 3084.15185823898, 3137.8117312961294, 41572.37641435381, 41624.583754162675, 41817.0, 41857.58142418567, 41869.79065104655, 8733.650653973897, 9379.0, 9422.811543769087, 9666.468344240993, 9693.369930954465, 17010.48968530946, 17023.744643830352, 17147.657046858993, 17155.056471894164, 17182.570435738955, 6437.2918978912285, 6456.160699109086, 6506.967465162644, 6529.118568993125, 6762.797116086525, 3234.1267857678295, 3270.133414645121, 3271.378438096754, 3337.7162941150273, 3356.9664303357144, 2570.383108054091, 2607.113581382339, 2607.843529388205, 2608.595667671514, 2609.0737788084957, 470.8658032460732, 474.65350294285366, 479.9208130658402, 481.1699817814312, 483.98604922686917, 491.263105341987, 492.2173743747459, 552.4116815591383, 568.6701713006529, 611.4252602553674, 7415.1472580652835, 7550.282723141293, 7868.842623147505, 8002.279794818494, 8139.75580732579, 588.9823305300848, 599.2030599302917, 600.1148306248336, 612.8712920540576, 631.3780925788095, 3317.353116142329, 3674.356987527172, 3720.069982504374, 3720.609336019679, 3792.3173828710546, 41868.79065604713, 42058.158836823095, 42682.57317426848, 42730.57269427328, 42854.35718464226, 37406.43890341647, 38094.428583571265, 38096.80951595224, 38486.23027539434, 38677.6132238674, 37976.99999999945, 40296.395554066716, 40842.59157408447, 41871.58128418738, 42004.36993445101, 8093.838123237385, 8122.147174546588, 8143.144969778088, 8160.877586836321, 8355.665773368997, 29185.41629167447, 29373.853130735064, 29500.11499655014, 31465.528017079305, 31874.043778686675, 35669.28661426809, 39792.801035994635, 40219.1956160881, 41279.38080928849, 41471.170576588906, 10272.280940334105, 10386.636467723594, 10422.530986105492, 10512.369257844553, 10534.104601108686, 10577.153827693919, 10752.193585481276, 11112.0, 11153.219274650697, 11201.991820735846, 8294.460860044077, 8876.733697989072, 10662.626808061681, 10897.727556811144, 11334.14993875446, 9746.561404736945, 10212.489375531046, 11267.774644507228, 11364.886351136383, 11696.239744416585, 10224.53989570486, 10873.836892446778, 10883.782324353628, 10891.0, 11037.724056898642, 8688.26149777276, 8776.341774367076, 8799.296056315607, 8956.238719708897, 9055.456672599665, 8768.561571921506, 9022.548872556477, 9346.485943272914, 9382.530873456437, 9458.43249405038], "unit": "score", "name": "yui.html", "value": 5626.0841337292795}], "name": "dromaeo_css", "value": 6108.885607483734}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 106.0, 113.0, 114.0, 113.0, 101.0, 113.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [155.0, 139.0, 159.0, 175.0, 132.0, 157.0, 161.0, 139.0, 187.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 154.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 160.0, 163.0, 163.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 104.0, 92.0, 74.0, 74.0, 75.0, 116.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 146.0, 95.0, 96.0, 95.0, 145.0, 95.0, 97.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 68.0, 69.0, 67.0, 76.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.7}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 69.0, 70.0, 78.0, 71.0, 71.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 91.0, 82.0, 83.0, 90.0, 92.0, 84.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [131.0, 124.0, 120.0, 119.0, 129.0, 122.0, 128.0, 134.0, 122.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.5}, {"lowerIsBetter": true, "replicates": [143.0, 139.0, 151.0, 152.0, 148.0, 138.0, 150.0, 154.0, 147.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 69.0, 69.0, 71.0, 73.0, 70.0, 71.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1552.1999999999996}]} 15:23:05 INFO - Return code: 0 15:23:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:23:05 ERROR - # TBPL SUCCESS # 15:23:05 INFO - Running post-action listener: _resource_record_post_action 15:23:05 INFO - Running post-run listener: _resource_record_post_run 15:23:06 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 482226176; Read time: 8; Write time: 461980 15:23:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 194281472; Read time: 0; Write time: 244804 15:23:07 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287944704; Read time: 8; Write time: 217176 15:23:07 INFO - Running post-run listener: _upload_blobber_files 15:23:07 INFO - Blob upload gear active. 15:23:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:23:07 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:23:07 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:23:07 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:23:07 INFO - (blobuploader) - INFO - Open directory for files ... 15:23:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:23:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:23:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:08 INFO - (blobuploader) - INFO - Done attempting. 15:23:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:23:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:23:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:23:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:23:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:23:08 INFO - (blobuploader) - INFO - Done attempting. 15:23:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:23:08 INFO - Return code: 0 15:23:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:23:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:23:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00b9c3092b5719450af42113506a587e94740113c5a40b5c6461a1ac4bcb6044fa438d87ba620f7b005512835e24379c9faa53e925eb502ebb37c391d9e0626f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19a4fc706cf45d0f80fd7ad7fecb86cb61c098dd84729596a262a853fc4120ab5142d967b0dab8a501f19211c27e60e781f709a372e123ddb01cdb951d4c19bb"} 15:23:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:23:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:23:08 INFO - Contents: 15:23:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00b9c3092b5719450af42113506a587e94740113c5a40b5c6461a1ac4bcb6044fa438d87ba620f7b005512835e24379c9faa53e925eb502ebb37c391d9e0626f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19a4fc706cf45d0f80fd7ad7fecb86cb61c098dd84729596a262a853fc4120ab5142d967b0dab8a501f19211c27e60e781f709a372e123ddb01cdb951d4c19bb"} 15:23:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:23:08 INFO - Copying logs to upload dir... 15:23:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:23:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.644221 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-09 15:23:08.601879) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 15:23:08.605527) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 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/00b9c3092b5719450af42113506a587e94740113c5a40b5c6461a1ac4bcb6044fa438d87ba620f7b005512835e24379c9faa53e925eb502ebb37c391d9e0626f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19a4fc706cf45d0f80fd7ad7fecb86cb61c098dd84729596a262a853fc4120ab5142d967b0dab8a501f19211c27e60e781f709a372e123ddb01cdb951d4c19bb"} build_url:https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/LBOW-rVcRceh9OSgtKQw9w/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/00b9c3092b5719450af42113506a587e94740113c5a40b5c6461a1ac4bcb6044fa438d87ba620f7b005512835e24379c9faa53e925eb502ebb37c391d9e0626f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/19a4fc706cf45d0f80fd7ad7fecb86cb61c098dd84729596a262a853fc4120ab5142d967b0dab8a501f19211c27e60e781f709a372e123ddb01cdb951d4c19bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 15:23:08.637439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:23:08.637798) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1457564527.780528-777955511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 15:23:08.724495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 15:23:08.725194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 15:23:08.725855) ========= ========= Total master_lag: 0.28 =========