builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1458926544.56 results: success (0) buildid: 20160325085737 builduid: 83a5d55494424f6c903f9d198a208105 revision: 51c718100df0fdd8d921eb62bcc180cfa765d9c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.563692) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.564341) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.564825) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006353 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.596662) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.596958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.625032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.625351) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.673927) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.674253) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.674589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.674900) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-25 10:22:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-03-25 10:22:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175030 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.863538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.863844) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017072 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.912745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:24.913067) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 51c718100df0fdd8d921eb62bcc180cfa765d9c0 --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 51c718100df0fdd8d921eb62bcc180cfa765d9c0 --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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-25 10:22:25,175 truncating revision to first 12 chars 2016-03-25 10:22:25,175 Setting DEBUG logging. 2016-03-25 10:22:25,175 attempt 1/10 2016-03-25 10:22:25,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/51c718100df0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 10:22:25,430 unpacking tar archive at: fx-team-51c718100df0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:25.459876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:25.460288) ========= echo 51c718100df0fdd8d921eb62bcc180cfa765d9c0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'51c718100df0fdd8d921eb62bcc180cfa765d9c0'] 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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 51c718100df0fdd8d921eb62bcc180cfa765d9c0 program finished with exit code 0 elapsedTime=0.003380 script_repo_revision: '51c718100df0fdd8d921eb62bcc180cfa765d9c0' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:25.508091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:25.508414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 10:22:25.518813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-03-25 10:22:25.519183) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:22:25 INFO - MultiFileLogger online at 20160325 10:22:25 in /builds/slave/test 10:22:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:22:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:22:25 INFO - {'append_to_log': False, 10:22:25 INFO - 'base_work_dir': '/builds/slave/test', 10:22:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:22:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:22:25 INFO - 'branch': 'Fx-Team-Non-PGO', 10:22:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:22:25 INFO - 'config_files': ('talos/linux_config.py',), 10:22:25 INFO - 'default_actions': ('clobber', 10:22:25 INFO - 'read-buildbot-config', 10:22:25 INFO - 'download-and-extract', 10:22:25 INFO - 'populate-webroot', 10:22:25 INFO - 'create-virtualenv', 10:22:25 INFO - 'install', 10:22:25 INFO - 'run-tests'), 10:22:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:22:25 INFO - 'download_minidump_stackwalk': True, 10:22:25 INFO - 'download_symbols': 'ondemand', 10:22:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:22:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:22:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:22:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:22:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:22:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:22:25 INFO - 'installer_path': 'installer.exe', 10:22:25 INFO - 'log_level': 'info', 10:22:25 INFO - 'log_name': 'talos', 10:22:25 INFO - 'log_to_console': True, 10:22:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:22:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:22:25 INFO - 'opt_config_files': (), 10:22:25 INFO - 'pip_index': False, 10:22:25 INFO - 'sps_profile': False, 10:22:25 INFO - 'sps_profile_interval': 0, 10:22:25 INFO - 'suite': 'dromaeojs', 10:22:25 INFO - 'system_bits': '32', 10:22:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:22:25 INFO - 'title': 'talos-linux64-ix-014', 10:22:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:22:25 INFO - 'use_talos_json': True, 10:22:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:22:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:22:25 INFO - 'work_dir': 'build'} 10:22:25 INFO - ##### 10:22:25 INFO - ##### Running clobber step. 10:22:25 INFO - ##### 10:22:25 INFO - Running pre-action listener: _resource_record_pre_action 10:22:25 INFO - Running main action method: clobber 10:22:25 INFO - rmtree: /builds/slave/test/build 10:22:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:22:26 INFO - Running post-action listener: _resource_record_post_action 10:22:26 INFO - ##### 10:22:26 INFO - ##### Running read-buildbot-config step. 10:22:26 INFO - ##### 10:22:26 INFO - Running pre-action listener: _resource_record_pre_action 10:22:26 INFO - Running main action method: read_buildbot_config 10:22:26 INFO - Using buildbot properties: 10:22:26 INFO - { 10:22:26 INFO - "project": "", 10:22:26 INFO - "product": "firefox", 10:22:26 INFO - "script_repo_revision": "production", 10:22:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:22:26 INFO - "repository": "", 10:22:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:22:26 INFO - "buildid": "20160325085737", 10:22:26 INFO - "pgo_build": "False", 10:22:26 INFO - "basedir": "/builds/slave/test", 10:22:26 INFO - "buildnumber": 1506, 10:22:26 INFO - "slavename": "talos-linux64-ix-014", 10:22:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:22:26 INFO - "platform": "ubuntu64_hw", 10:22:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:22:26 INFO - "branch": "fx-team", 10:22:26 INFO - "repo_path": "integration/fx-team", 10:22:26 INFO - "revision": "51c718100df0fdd8d921eb62bcc180cfa765d9c0", 10:22:26 INFO - "stage_platform": "linux64", 10:22:26 INFO - "builduid": "83a5d55494424f6c903f9d198a208105", 10:22:26 INFO - "slavebuilddir": "test" 10:22:26 INFO - } 10:22:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:22:26 INFO - Running post-action listener: _resource_record_post_action 10:22:26 INFO - ##### 10:22:26 INFO - ##### Running download-and-extract step. 10:22:26 INFO - ##### 10:22:26 INFO - Running pre-action listener: _resource_record_pre_action 10:22:26 INFO - Running main action method: download_and_extract 10:22:26 INFO - mkdir: /builds/slave/test/build/tests 10:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:26 INFO - https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:22:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:22:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:22:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:31 INFO - Downloaded 1361 bytes. 10:22:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:22:31 INFO - Using the following test package requirements: 10:22:31 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:22:31 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:22:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:22:31 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:22:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:22:31 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:22:31 INFO - u'jsshell-linux-x86_64.zip'], 10:22:31 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:22:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:22:31 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:22:31 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:22:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:22:31 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:22:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:22:31 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:22:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:22:31 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:22:31 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:22:31 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:22:31 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')]} 10:22:31 INFO - https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:22:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:22:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:22:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:34 INFO - Downloaded 22085406 bytes. 10:22:34 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'] 10:22:34 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 10:22:35 INFO - Return code: 0 10:22:35 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 10:22: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')]} 10:22:35 INFO - https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:37 INFO - Downloaded 22085406 bytes. 10:22:37 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'] 10:22:37 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 10:22:39 INFO - Return code: 0 10:22: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')]} 10:22:39 INFO - https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:22:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:22:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:22:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:40 INFO - Downloaded 10847531 bytes. 10:22: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'] 10:22: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 10:22:40 INFO - Return code: 0 10:22: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')]} 10:22:40 INFO - https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VReyG25tSXCQfYf-IfzgeA/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 10:22:42 INFO - Downloaded 54262981 bytes. 10:22:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:22:42 INFO - mkdir: /builds/slave/test/properties 10:22:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:22:42 INFO - Writing to file /builds/slave/test/properties/build_url 10:22:42 INFO - Contents: 10:22:42 INFO - build_url:https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:22:43 INFO - Running post-action listener: _resource_record_post_action 10:22:43 INFO - Running post-action listener: set_extra_try_arguments 10:22:43 INFO - ##### 10:22:43 INFO - ##### Running populate-webroot step. 10:22:43 INFO - ##### 10:22:43 INFO - Running pre-action listener: _resource_record_pre_action 10:22:43 INFO - Running main action method: populate_webroot 10:22:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:22:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:22:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:22:43 INFO - '--tppagecycles', 10:22:43 INFO - '7'], 10:22:43 INFO - 'tests': ['tsvgm']}}, 10:22:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:22:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:22:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:22:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:22:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:22:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:43 INFO - 'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:22:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:43 INFO - 'tests': ['damp', 'tps']}, 10:22:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:43 INFO - 'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['damp', 'tps']}, 10:22:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:22:43 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['dromaeo_dom']}, 10:22:43 INFO - 'other': {'tests': ['a11yr', 10:22:43 INFO - 'ts_paint', 10:22:43 INFO - 'tpaint', 10:22:43 INFO - 'sessionrestore', 10:22:43 INFO - 'sessionrestore_no_auto_restore', 10:22:43 INFO - 'tabpaint']}, 10:22:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['a11yr', 10:22:43 INFO - 'ts_paint', 10:22:43 INFO - 'tpaint', 10:22:43 INFO - 'sessionrestore', 10:22:43 INFO - 'sessionrestore_no_auto_restore', 10:22:43 INFO - 'tabpaint']}, 10:22:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['a11yr', 10:22:43 INFO - 'ts_paint', 10:22:43 INFO - 'tpaint', 10:22:43 INFO - 'sessionrestore', 10:22:43 INFO - 'sessionrestore_no_auto_restore', 10:22:43 INFO - 'tabpaint']}, 10:22:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['a11yr', 10:22:43 INFO - 'ts_paint', 10:22:43 INFO - 'tpaint', 10:22:43 INFO - 'sessionrestore', 10:22:43 INFO - 'sessionrestore_no_auto_restore', 10:22:43 INFO - 'tabpaint']}, 10:22:43 INFO - 'other_l64': {'tests': ['a11yr', 10:22:43 INFO - 'ts_paint', 10:22:43 INFO - 'tpaint', 10:22:43 INFO - 'sessionrestore', 10:22:43 INFO - 'sessionrestore_no_auto_restore', 10:22:43 INFO - 'tabpaint']}, 10:22:43 INFO - 'other_nol64': {'tests': ['a11yr', 10:22:43 INFO - 'ts_paint', 10:22:43 INFO - 'tpaint', 10:22:43 INFO - 'sessionrestore', 10:22:43 INFO - 'sessionrestore_no_auto_restore', 10:22:43 INFO - 'tabpaint']}, 10:22:43 INFO - 'svgr': {'tests': ['tsvgx', 10:22:43 INFO - 'tsvgr_opacity', 10:22:43 INFO - 'tart', 10:22:43 INFO - 'tscrollx', 10:22:43 INFO - 'cart']}, 10:22:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['tsvgx', 10:22:43 INFO - 'tsvgr_opacity', 10:22:43 INFO - 'tart', 10:22:43 INFO - 'tscrollx', 10:22:43 INFO - 'cart']}, 10:22:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:43 INFO - 'tests': ['tp5o']}, 10:22:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:43 INFO - 'talos_options': ['--e10s'], 10:22:43 INFO - 'tests': ['tp5o']}, 10:22:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:43 INFO - 'talos_options': ['--xperf_path', 10:22:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:22:43 INFO - 'tests': ['tp5n']}, 10:22:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:22:43 INFO - 'talos_options': ['--e10s', 10:22:43 INFO - '--xperf_path', 10:22:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:22:43 INFO - 'tests': ['tp5n']}}, 10:22:43 INFO - 'talos.zip': {'path': '', 10:22:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:22:43 INFO - Running post-action listener: _resource_record_post_action 10:22:43 INFO - ##### 10:22:43 INFO - ##### Running create-virtualenv step. 10:22:43 INFO - ##### 10:22:43 INFO - Running pre-action listener: _resource_record_pre_action 10:22:43 INFO - Running main action method: create_virtualenv 10:22:43 INFO - Creating virtualenv /builds/slave/test/build/venv 10:22:43 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 10:22:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:22:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:22:43 INFO - Using real prefix '/usr' 10:22:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:22:43 INFO - Installing distribute.............................................................................................................................................................................................done. 10:22:45 INFO - Installing pip.................done. 10:22:45 INFO - Return code: 0 10:22:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:45 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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:22:45 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 10:22:45 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 10:22:45 INFO - Using env: {'DISPLAY': ':0', 10:22:45 INFO - 'HOME': '/home/cltbld', 10:22:45 INFO - 'LANG': 'en_US.UTF-8', 10:22:45 INFO - 'LANGUAGE': 'en_US:en', 10:22:45 INFO - 'LOGNAME': 'cltbld', 10:22:45 INFO - 'MAIL': '/var/mail/cltbld', 10:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:45 INFO - 'MOZ_NO_REMOTE': '1', 10:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:45 INFO - 'NO_EM_RESTART': '1', 10:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:45 INFO - 'PWD': '/builds/slave/test', 10:22:45 INFO - 'SHELL': '/bin/bash', 10:22:45 INFO - 'SHLVL': '1', 10:22:45 INFO - 'TERM': 'linux', 10:22:45 INFO - 'TMOUT': '86400', 10:22:45 INFO - 'USER': 'cltbld', 10:22:45 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:45 INFO - '_': '/tools/buildbot/bin/python'} 10:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:45 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 10:22:45 INFO - Cleaning up... 10:22:45 INFO - Return code: 0 10:22:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:45 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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:22:45 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 10:22:45 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 10:22:45 INFO - Using env: {'DISPLAY': ':0', 10:22:45 INFO - 'HOME': '/home/cltbld', 10:22:45 INFO - 'LANG': 'en_US.UTF-8', 10:22:45 INFO - 'LANGUAGE': 'en_US:en', 10:22:45 INFO - 'LOGNAME': 'cltbld', 10:22:45 INFO - 'MAIL': '/var/mail/cltbld', 10:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:45 INFO - 'MOZ_NO_REMOTE': '1', 10:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:45 INFO - 'NO_EM_RESTART': '1', 10:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:45 INFO - 'PWD': '/builds/slave/test', 10:22:45 INFO - 'SHELL': '/bin/bash', 10:22:45 INFO - 'SHLVL': '1', 10:22:45 INFO - 'TERM': 'linux', 10:22:45 INFO - 'TMOUT': '86400', 10:22:45 INFO - 'USER': 'cltbld', 10:22:45 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:45 INFO - '_': '/tools/buildbot/bin/python'} 10:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:46 INFO - Downloading/unpacking psutil>=0.7.1 10:22:46 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 10:22:46 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 10:22:46 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 10:22:46 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 10:22:46 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 10:22:46 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 10:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:22:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:22:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:22:48 INFO - Installing collected packages: psutil 10:22:48 INFO - Running setup.py install for psutil 10:22:48 INFO - building 'psutil._psutil_linux' extension 10:22:48 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 10:22:48 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 10:22:48 INFO - building 'psutil._psutil_posix' extension 10:22:48 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 10:22:48 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 10:22:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:22:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:22:48 INFO - Successfully installed psutil 10:22:48 INFO - Cleaning up... 10:22:48 INFO - Return code: 0 10:22:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:22: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')]} 10:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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')]} 10:22:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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', '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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:22: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:22: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 mozsystemmonitor==0.0.0 10:22:48 INFO - Using env: {'DISPLAY': ':0', 10:22:48 INFO - 'HOME': '/home/cltbld', 10:22:48 INFO - 'LANG': 'en_US.UTF-8', 10:22:48 INFO - 'LANGUAGE': 'en_US:en', 10:22:48 INFO - 'LOGNAME': 'cltbld', 10:22:48 INFO - 'MAIL': '/var/mail/cltbld', 10:22:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:48 INFO - 'MOZ_NO_REMOTE': '1', 10:22:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:48 INFO - 'NO_EM_RESTART': '1', 10:22:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:48 INFO - 'PWD': '/builds/slave/test', 10:22:48 INFO - 'SHELL': '/bin/bash', 10:22:48 INFO - 'SHLVL': '1', 10:22:48 INFO - 'TERM': 'linux', 10:22:48 INFO - 'TMOUT': '86400', 10:22:48 INFO - 'USER': 'cltbld', 10:22:48 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:22:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:48 INFO - '_': '/tools/buildbot/bin/python'} 10:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:22:50 INFO - Installing collected packages: mozsystemmonitor 10:22:50 INFO - Running setup.py install for mozsystemmonitor 10:22:50 INFO - Successfully installed mozsystemmonitor 10:22:50 INFO - Cleaning up... 10:22:50 INFO - Return code: 0 10:22:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:22: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')]} 10:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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')]} 10:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22: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', '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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:22: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:22: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 blobuploader==1.2.4 10:22:50 INFO - Using env: {'DISPLAY': ':0', 10:22:50 INFO - 'HOME': '/home/cltbld', 10:22:50 INFO - 'LANG': 'en_US.UTF-8', 10:22:50 INFO - 'LANGUAGE': 'en_US:en', 10:22:50 INFO - 'LOGNAME': 'cltbld', 10:22:50 INFO - 'MAIL': '/var/mail/cltbld', 10:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:50 INFO - 'MOZ_NO_REMOTE': '1', 10:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:50 INFO - 'NO_EM_RESTART': '1', 10:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:50 INFO - 'PWD': '/builds/slave/test', 10:22:50 INFO - 'SHELL': '/bin/bash', 10:22:50 INFO - 'SHLVL': '1', 10:22:50 INFO - 'TERM': 'linux', 10:22:50 INFO - 'TMOUT': '86400', 10:22:50 INFO - 'USER': 'cltbld', 10:22:50 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:50 INFO - '_': '/tools/buildbot/bin/python'} 10:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:52 INFO - Downloading blobuploader-1.2.4.tar.gz 10:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:22:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:22:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22: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 10:22:53 INFO - Downloading docopt-0.6.1.tar.gz 10:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:22:53 INFO - Installing collected packages: blobuploader, requests, docopt 10:22:53 INFO - Running setup.py install for blobuploader 10:22:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:22:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:22:53 INFO - Running setup.py install for requests 10:22:54 INFO - Running setup.py install for docopt 10:22:54 INFO - Successfully installed blobuploader requests docopt 10:22:54 INFO - Cleaning up... 10:22:54 INFO - Return code: 0 10:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:54 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')]} 10:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:54 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')]} 10:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:54 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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:22:54 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 10:22:54 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 10:22:54 INFO - Using env: {'DISPLAY': ':0', 10:22:54 INFO - 'HOME': '/home/cltbld', 10:22:54 INFO - 'LANG': 'en_US.UTF-8', 10:22:54 INFO - 'LANGUAGE': 'en_US:en', 10:22:54 INFO - 'LOGNAME': 'cltbld', 10:22:54 INFO - 'MAIL': '/var/mail/cltbld', 10:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:54 INFO - 'MOZ_NO_REMOTE': '1', 10:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:54 INFO - 'NO_EM_RESTART': '1', 10:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:54 INFO - 'PWD': '/builds/slave/test', 10:22:54 INFO - 'SHELL': '/bin/bash', 10:22:54 INFO - 'SHLVL': '1', 10:22:54 INFO - 'TERM': 'linux', 10:22:54 INFO - 'TMOUT': '86400', 10:22:54 INFO - 'USER': 'cltbld', 10:22:54 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:54 INFO - '_': '/tools/buildbot/bin/python'} 10:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:54 INFO - Running setup.py (path:/tmp/pip-IGChcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:54 INFO - Running setup.py (path:/tmp/pip-cGfolo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:54 INFO - Running setup.py (path:/tmp/pip-MsCfkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:54 INFO - Running setup.py (path:/tmp/pip-oYfZV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:54 INFO - Running setup.py (path:/tmp/pip-Co54ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:54 INFO - Running setup.py (path:/tmp/pip-qJXmLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:54 INFO - Running setup.py (path:/tmp/pip-ljm6h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:55 INFO - Running setup.py (path:/tmp/pip-Hp690f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:55 INFO - Running setup.py (path:/tmp/pip-x4B48h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:55 INFO - Running setup.py (path:/tmp/pip-AOYzbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:55 INFO - Running setup.py (path:/tmp/pip-OSaOQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:55 INFO - Running setup.py (path:/tmp/pip-vOE758-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:55 INFO - Running setup.py (path:/tmp/pip-DujDGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:55 INFO - Running setup.py (path:/tmp/pip-lH4DRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:55 INFO - Running setup.py (path:/tmp/pip-q_zOGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:55 INFO - Running setup.py (path:/tmp/pip-xgIUbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:55 INFO - Running setup.py (path:/tmp/pip-1J7HRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:22:55 INFO - Running setup.py install for manifestparser 10:22:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:22:55 INFO - Running setup.py install for mozcrash 10:22:55 INFO - Running setup.py install for mozdebug 10:22:56 INFO - Running setup.py install for mozdevice 10:22:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Running setup.py install for mozfile 10:22:56 INFO - Running setup.py install for mozhttpd 10:22:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Running setup.py install for mozinfo 10:22:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Running setup.py install for mozInstall 10:22:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Running setup.py install for mozleak 10:22:56 INFO - Running setup.py install for mozlog 10:22:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Running setup.py install for moznetwork 10:22:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:22:56 INFO - Running setup.py install for mozprocess 10:22:56 INFO - Running setup.py install for mozprofile 10:22:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:22:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:22:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:22:57 INFO - Running setup.py install for mozrunner 10:22:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:22:57 INFO - Running setup.py install for mozscreenshot 10:22:57 INFO - Running setup.py install for moztest 10:22:57 INFO - Running setup.py install for mozversion 10:22:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:22:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:22:57 INFO - Cleaning up... 10:22:57 INFO - Return code: 0 10:22:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:22:57 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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:22:57 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 10:22:57 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 10:22:57 INFO - Using env: {'DISPLAY': ':0', 10:22:57 INFO - 'HOME': '/home/cltbld', 10:22:57 INFO - 'LANG': 'en_US.UTF-8', 10:22:57 INFO - 'LANGUAGE': 'en_US:en', 10:22:57 INFO - 'LOGNAME': 'cltbld', 10:22:57 INFO - 'MAIL': '/var/mail/cltbld', 10:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:57 INFO - 'MOZ_NO_REMOTE': '1', 10:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:22:57 INFO - 'NO_EM_RESTART': '1', 10:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:57 INFO - 'PWD': '/builds/slave/test', 10:22:57 INFO - 'SHELL': '/bin/bash', 10:22:57 INFO - 'SHLVL': '1', 10:22:57 INFO - 'TERM': 'linux', 10:22:57 INFO - 'TMOUT': '86400', 10:22:57 INFO - 'USER': 'cltbld', 10:22:57 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:57 INFO - '_': '/tools/buildbot/bin/python'} 10:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:22:57 INFO - Running setup.py (path:/tmp/pip-S2Zkpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:22:57 INFO - Running setup.py (path:/tmp/pip-R1tVWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:22:57 INFO - Running setup.py (path:/tmp/pip-yF04DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:22:57 INFO - Running setup.py (path:/tmp/pip-_CSKct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:22:58 INFO - Running setup.py (path:/tmp/pip-PhKHfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:22:58 INFO - Running setup.py (path:/tmp/pip-d3p9gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:22:58 INFO - Running setup.py (path:/tmp/pip-L3zgMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:22:58 INFO - Running setup.py (path:/tmp/pip-EEWViC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:22:58 INFO - Running setup.py (path:/tmp/pip-CHFuLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:22:58 INFO - Running setup.py (path:/tmp/pip-dxAIN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:22:58 INFO - Running setup.py (path:/tmp/pip-1dErZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:22:58 INFO - Running setup.py (path:/tmp/pip-KruEjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:22:58 INFO - Running setup.py (path:/tmp/pip-mOTIUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:22:58 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)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:22:58 INFO - Running setup.py (path:/tmp/pip-2OZ5V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:58 INFO - Running setup.py (path:/tmp/pip-wlMlNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:22:58 INFO - Running setup.py (path:/tmp/pip-eWSvzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:22:58 INFO - Running setup.py (path:/tmp/pip-a9NTa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:22:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:22:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:22:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:00 INFO - Downloading blessings-1.6.tar.gz 10:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:23:00 INFO - Installing collected packages: blessings 10:23:00 INFO - Running setup.py install for blessings 10:23:00 INFO - Successfully installed blessings 10:23:00 INFO - Cleaning up... 10:23:01 INFO - Return code: 0 10:23:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:23:01 INFO - Reading from file tmpfile_stdout 10:23:01 INFO - Current package versions: 10:23:01 INFO - argparse == 1.2.1 10:23:01 INFO - blessings == 1.6 10:23:01 INFO - blobuploader == 1.2.4 10:23:01 INFO - docopt == 0.6.1 10:23:01 INFO - manifestparser == 1.1 10:23:01 INFO - mozInstall == 1.12 10:23:01 INFO - mozcrash == 0.17 10:23:01 INFO - mozdebug == 0.1 10:23:01 INFO - mozdevice == 0.48 10:23:01 INFO - mozfile == 1.2 10:23:01 INFO - mozhttpd == 0.7 10:23:01 INFO - mozinfo == 0.9 10:23:01 INFO - mozleak == 0.1 10:23:01 INFO - mozlog == 3.1 10:23:01 INFO - moznetwork == 0.27 10:23:01 INFO - mozprocess == 0.22 10:23:01 INFO - mozprofile == 0.28 10:23:01 INFO - mozrunner == 6.11 10:23:01 INFO - mozscreenshot == 0.1 10:23:01 INFO - mozsystemmonitor == 0.0 10:23:01 INFO - moztest == 0.7 10:23:01 INFO - mozversion == 1.4 10:23:01 INFO - psutil == 3.1.1 10:23:01 INFO - requests == 1.2.3 10:23:01 INFO - wsgiref == 0.1.2 10:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:01 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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:23:01 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 10:23:01 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 10:23:01 INFO - Using env: {'DISPLAY': ':0', 10:23:01 INFO - 'HOME': '/home/cltbld', 10:23:01 INFO - 'LANG': 'en_US.UTF-8', 10:23:01 INFO - 'LANGUAGE': 'en_US:en', 10:23:01 INFO - 'LOGNAME': 'cltbld', 10:23:01 INFO - 'MAIL': '/var/mail/cltbld', 10:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:01 INFO - 'MOZ_NO_REMOTE': '1', 10:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:01 INFO - 'NO_EM_RESTART': '1', 10:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:01 INFO - 'PWD': '/builds/slave/test', 10:23:01 INFO - 'SHELL': '/bin/bash', 10:23:01 INFO - 'SHLVL': '1', 10:23:01 INFO - 'TERM': 'linux', 10:23:01 INFO - 'TMOUT': '86400', 10:23:01 INFO - 'USER': 'cltbld', 10:23:01 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:01 INFO - '_': '/tools/buildbot/bin/python'} 10:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 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)) 10:23:01 INFO - Cleaning up... 10:23:01 INFO - Return code: 0 10:23:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:01 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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:23:01 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 10:23:01 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 10:23:01 INFO - Using env: {'DISPLAY': ':0', 10:23:01 INFO - 'HOME': '/home/cltbld', 10:23:01 INFO - 'LANG': 'en_US.UTF-8', 10:23:01 INFO - 'LANGUAGE': 'en_US:en', 10:23:01 INFO - 'LOGNAME': 'cltbld', 10:23:01 INFO - 'MAIL': '/var/mail/cltbld', 10:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:01 INFO - 'MOZ_NO_REMOTE': '1', 10:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:01 INFO - 'NO_EM_RESTART': '1', 10:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:01 INFO - 'PWD': '/builds/slave/test', 10:23:01 INFO - 'SHELL': '/bin/bash', 10:23:01 INFO - 'SHLVL': '1', 10:23:01 INFO - 'TERM': 'linux', 10:23:01 INFO - 'TMOUT': '86400', 10:23:01 INFO - 'USER': 'cltbld', 10:23:01 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:01 INFO - '_': '/tools/buildbot/bin/python'} 10:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:01 INFO - Downloading/unpacking jsonschema 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:23:03 INFO - Downloading/unpacking functools32 (from jsonschema) 10:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:23:04 INFO - warning: no files found matching '*.txt' 10:23:04 INFO - no previously-included directories found matching 'build' 10:23:04 INFO - no previously-included directories found matching 'dist' 10:23:04 INFO - no previously-included directories found matching '.git*' 10:23:04 INFO - Installing collected packages: jsonschema, functools32 10:23:04 INFO - Running setup.py install for functools32 10:23:04 INFO - warning: no files found matching '*.txt' 10:23:04 INFO - no previously-included directories found matching 'build' 10:23:04 INFO - no previously-included directories found matching 'dist' 10:23:04 INFO - no previously-included directories found matching '.git*' 10:23:04 INFO - Successfully installed jsonschema functools32 10:23:04 INFO - Cleaning up... 10:23:04 INFO - Return code: 0 10:23:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:04 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 0x7feb46dbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c17d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', '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 10:23:04 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 10:23:04 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 10:23:04 INFO - Using env: {'DISPLAY': ':0', 10:23:04 INFO - 'HOME': '/home/cltbld', 10:23:04 INFO - 'LANG': 'en_US.UTF-8', 10:23:04 INFO - 'LANGUAGE': 'en_US:en', 10:23:04 INFO - 'LOGNAME': 'cltbld', 10:23:04 INFO - 'MAIL': '/var/mail/cltbld', 10:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:04 INFO - 'MOZ_NO_REMOTE': '1', 10:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:04 INFO - 'NO_EM_RESTART': '1', 10:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:04 INFO - 'PWD': '/builds/slave/test', 10:23:04 INFO - 'SHELL': '/bin/bash', 10:23:04 INFO - 'SHLVL': '1', 10:23:04 INFO - 'TERM': 'linux', 10:23:04 INFO - 'TMOUT': '86400', 10:23:04 INFO - 'USER': 'cltbld', 10:23:04 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:04 INFO - '_': '/tools/buildbot/bin/python'} 10:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:04 INFO - Downloading/unpacking flake8 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:23:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:23:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23: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 10:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:23:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:23:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:23:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:23:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:23:07 INFO - no previously-included directories found matching 'docs/_build' 10:23:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:23:07 INFO - Running setup.py install for pep8 10:23:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:23:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:23:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:23:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:23:07 INFO - no previously-included directories found matching 'docs/_build' 10:23:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:23:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:23:07 INFO - Cleaning up... 10:23:07 INFO - Return code: 0 10:23:07 INFO - Running post-action listener: _resource_record_post_action 10:23:07 INFO - Running post-action listener: _start_resource_monitoring 10:23:07 INFO - Starting resource monitoring. 10:23:07 INFO - ##### 10:23:07 INFO - ##### Running install step. 10:23:07 INFO - ##### 10:23:07 INFO - Running pre-action listener: _resource_record_pre_action 10:23:07 INFO - Running main action method: install 10:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:23:07 INFO - Reading from file tmpfile_stdout 10:23:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:23:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:23:07 INFO - Reading from file tmpfile_stdout 10:23:07 INFO - Output received: 10:23:07 INFO - Usage: mozinstall [options] installer 10:23:07 INFO - Options: 10:23:07 INFO - -h, --help show this help message and exit 10:23:07 INFO - -d DEST, --destination=DEST 10:23:07 INFO - Directory to install application into. [default: 10:23:07 INFO - "/builds/slave/test"] 10:23:07 INFO - --app=APP Application being installed. [default: firefox] 10:23:07 INFO - mkdir: /builds/slave/test/build/application 10:23:07 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'] 10:23:07 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 10:23:23 INFO - Reading from file tmpfile_stdout 10:23:23 INFO - Output received: 10:23:23 INFO - /builds/slave/test/build/application/firefox/firefox 10:23:23 INFO - Running post-action listener: _resource_record_post_action 10:23:23 INFO - ##### 10:23:23 INFO - ##### Running run-tests step. 10:23:23 INFO - ##### 10:23:23 INFO - Running pre-action listener: _resource_record_pre_action 10:23:23 INFO - Running main action method: run_tests 10:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:23:23 INFO - Python 2.7.3 10:23:23 INFO - Return code: 0 10:23:23 INFO - grabbing minidump binary from tooltool 10:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:23 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 0x2850640>, '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 0x2851540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28519d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:23:23 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 10:23:23 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 10:23:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:23:23 INFO - Return code: 0 10:23:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:23:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:23:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:23:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:23:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:23:24 INFO - Return code: 0 10:23:24 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/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 10:23:24 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/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 10:23:24 INFO - Using env: {'DISPLAY': ':0', 10:23:24 INFO - 'HOME': '/home/cltbld', 10:23:24 INFO - 'LANG': 'en_US.UTF-8', 10:23:24 INFO - 'LANGUAGE': 'en_US:en', 10:23:24 INFO - 'LOGNAME': 'cltbld', 10:23:24 INFO - 'MAIL': '/var/mail/cltbld', 10:23:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:23:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:24 INFO - 'MOZ_NO_REMOTE': '1', 10:23:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:23:24 INFO - 'NO_EM_RESTART': '1', 10:23:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:24 INFO - 'PWD': '/builds/slave/test', 10:23:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:23:24 INFO - 'SHELL': '/bin/bash', 10:23:24 INFO - 'SHLVL': '1', 10:23:24 INFO - 'TERM': 'linux', 10:23:24 INFO - 'TMOUT': '86400', 10:23:24 INFO - 'USER': 'cltbld', 10:23:24 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807', 10:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:24 INFO - '_': '/tools/buildbot/bin/python'} 10:23:24 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/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 10:23:24 INFO - mozversion application_buildid: 20160325085737 10:23:24 INFO - mozversion application_changeset: 51c718100df0fdd8d921eb62bcc180cfa765d9c0 10:23:24 INFO - mozversion application_display_name: Nightly 10:23:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:23:24 INFO - mozversion application_name: Firefox 10:23:24 INFO - mozversion application_remotingname: firefox 10:23:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:23:24 INFO - mozversion application_vendor: Mozilla 10:23:24 INFO - mozversion application_version: 48.0a1 10:23:24 INFO - mozversion platform_buildid: 20160325085737 10:23:24 INFO - mozversion platform_changeset: 51c718100df0fdd8d921eb62bcc180cfa765d9c0 10:23:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:23:24 INFO - mozversion platform_version: 48.0a1 10:23:24 INFO - using testdate: 1458926604 10:23:24 INFO - actual date: 1458926604 10:23:24 INFO - starting webserver on 'localhost:51002' 10:23:24 INFO - SUITE-START | Running 2 tests 10:23:24 INFO - TEST-START | dromaeo_css 10:23:24 INFO - operating with platform_type : linux_ 10:23:24 INFO - Initialising browser for dromaeo_css test... 10:23:24 INFO - TEST-INFO | started process 6669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5dtzro/profile http://localhost:51002/getInfo.html) 10:23:28 INFO - PROCESS | 6669 | __metrics Screen width/height:1600/1200 10:23:28 INFO - PROCESS | 6669 | colorDepth:24 10:23:28 INFO - PROCESS | 6669 | Browser inner width/height: 1024/697 10:23:28 INFO - PROCESS | 6669 | __metrics 10:23:29 ERROR - PROCESS | 6669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:23:29 INFO - PROCESS | 6669 | 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. 10:23:30 INFO - TEST-INFO | 6669: exit 0 10:23:30 INFO - Browser initialized. 10:23:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:23:30 INFO - TEST-INFO | started process 6765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5dtzro/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:42 INFO - PROCESS | 6765 | RSS: Main: 155099136 10:23:42 INFO - PROCESS | 6765 | 10:24:33 INFO - PROCESS | 6765 | 1458926673765 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] 10:26:45 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:51002/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51002/tests/dromaeo/cssquery-ext.html) 10:26:46 INFO - PROCESS | 6765 | RSS: Main: 243904512 10:26:46 INFO - PROCESS | 6765 | 10:29:48 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:51002/tests/dromaeo/cssquery-ext.html (next: http://localhost:51002/tests/dromaeo/cssquery-jquery.html) 10:29:49 INFO - PROCESS | 6765 | RSS: Main: 232460288 10:29:49 INFO - PROCESS | 6765 | 10:32:50 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:51002/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51002/tests/dromaeo/cssquery-mootools.html) 10:32:51 INFO - PROCESS | 6765 | RSS: Main: 232370176 10:32:51 INFO - PROCESS | 6765 | 10:35:53 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:51002/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51002/tests/dromaeo/cssquery-prototype.html) 10:35:54 INFO - PROCESS | 6765 | RSS: Main: 209408000 10:35:54 INFO - PROCESS | 6765 | 10:38:56 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:51002/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51002/tests/dromaeo/cssquery-yui.html) 10:38:57 INFO - PROCESS | 6765 | RSS: Main: 201826304 10:38:57 INFO - PROCESS | 6765 | 10:41:59 INFO - PROCESS | 6765 | Cycle 1(1): loaded http://localhost:51002/tests/dromaeo/cssquery-yui.html (next: http://localhost:51002/tests/dromaeo/cssquery-dojo.html) 10:42:00 INFO - PROCESS | 6765 | RSS: Main: 270340096 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - PROCESS | 6765 | __start_tp_report 10:42:00 INFO - PROCESS | 6765 | _x_x_mozilla_page_load 10:42:00 INFO - PROCESS | 6765 | _x_x_mozilla_page_load_details 10:42:00 INFO - PROCESS | 6765 | |i|pagename|runs| 10:42:00 INFO - PROCESS | 6765 | |0;dojo.html;2619.266605350502;2717;2723.305557082946;2724.5776904579784;2765.2119146043374;4566.725996440207;4675.532446755327;4679.8362057328;4690.06198760248;4698.08387364464;4641.582257596816;4680.555347242007;4681.4382274127065;4691.648126390517;4786.258129989848;4168.7081904266715;4271.9359209611885;4299.978500107503;4309.784510774464;4419.160359531695;4227.513835908864;4341.739495630257;4364.869053928387;4396.296592545194;4399.846005389812;4259.190753756808;4290.528041915387;4330.350447432878;4330.935035974463;4338.2191205582985;4281.336392859112;4287.656987440997;4300.053988122608;4324.459442569679;4333.653307735373;4197.517285512175;4267.174285912585;4267.701260911737;4297.226499230137;4314.072474417983;4553.590176884097;4573.245414506602;4578.427696537933;4595.080983803219;4637.744924029177;5018.77415516299;5028.296038554606;5030.622703297231;5038.2190760432195;5079.314292570492;4917.7786999585105;5040.16837221858;5061.772220250097;5062.544371006627;5069.518395752398;4717.339572459859;4726.929096063562;4735.928961065587;4751.59611433032;4774.809007639725;5152.27868098459;5154.407243167008;5158.4067832199025;5165.664231824994;5175.870603234874;4873.293372460973;4926.1379258629595;4953.851384458472;4985.302057711923;5001.299818025479;5003.974980125076;5021.623378246573;5030.974845125751;5031.647784655112;5040.067587496325;4980.477049909779;4988.575971042429;4989.226669866177;4991.3511243538105;5026.195808670668;4866.562009419169;5002.374703162105;5013.323201367842;5064.468230835783;5078.466760990117;4254.532001479834;4262.147570485915;4279.743215407086;4282.9785851071165;4327.069680018811;3758.0792705787258;3761.0033341164612;3766.5291838520184;3779.60314167014;3793.279276937373;4233.618974292329;4248.4901811782165;4299.54854740254;4312.805923733439;4329.242382583036;4996.15065438869;5051.116054690415;5069.923951140736;5076.18780995039;5087.567556757717;4368.541303163186;4377.781110944504;4380.233459144637;4381.255186618282;4427.40230068943;4457.531959144308;4521.706089104264;4560.543945605413;4589.655775816827;4605.309203619417;4739.289106634033;4743.952560474351;4787.784549695341;4789.808407663654;4844.515548445127;4896.804127834989;5024.824131155392;5030.220315851049;5036.823711170092;5093.567046801063;4730.6215502759005;4797.304390863375;4798.848276413705;4812.326274321527;4839.201531747222;4856.78144483492;4861.51384861511;4864.610831133572;4865.367502224688;4909.361782968192;4922.163232250455;4923.655344125877;4938.703677779345;4971;4988.4263309719845;4868.440129385024;4883.121038213014;4884;4885.267209918541;4935.531124543163;4888.413390393175;4889.559939605452;4896.11869863428;4898.4121905371585;4933;4719.551642593948;4813;4822.059698358787;4861.1979023462145;4875.658703890694;4873.317735516959;4897.363342765418;4911.386076740408;4923;4940.036692844861;4806.447258565309;4808.08646357191;4808.230683090689;4814.277858321279;4844.806207751651 10:42:00 INFO - PROCESS | 6765 | |1;ext.html;523.2857149990265;537.0842713174038;542.035177384256;562.8714427572718;575.9596828222024;27056.188314350577;27464.588031179548;34318.485222721676;34734.8263258684;34758.30483390337;37972.43041354382;38092.619073809255;38334.233315333746;38472.230555388946;38503.80748096263;7527.13437954634;7701.653425595861;7703.961480192591;7715.228477152296;7719.961400192991;7623.695052197905;7722.806929826743;7738.883916741253;7753.961230193841;7759.107702614187;7914.089879663855;7980.8403831923615;7986.2413070758475;7987.201279871995;8004.879926801103;7853.371730261565;7903.051633803922;7967.402444816633;7970.4819186752675;7973.362131029504;7707.845843083107;7897;7904.762857114296;7911;7918.168592297783;35283.647163528294;35567;35632.46551301733;35666;35717.10707232314;3076.446239676857;3247.0745837436452;3309.9503507447407;3404.0808981574837;3512.982435087834;29168.41663166746;29746.70253297461;30056.8497157515;30169.698303016907;30758.53862192069;3447.879324223665;3455.6026057003514;3484.337975784593;3502.3345564342694;3551.4672799080085;238295;239852.80073599695;239943;239947;239955;42263.57736422658;54600.45399545954;54671.45328546743;54980;55016.524256407756;40794.796026020274;41147.7942610285;41151.7942410292;41176.38235426471;41197.1760564793;12864.614061578168;13068.477260909647;13071.15037522558;13072.281024543741;13078.869211307765;9825.9017409825;9913.900860991442;9913.900860991442;9919.702408927744;9994.050565196294;14700.926495367456;14790.778138327934;14793.556193314218;14842.257887105601;14934.925325373304;5514.558835293167;5730.856728581735;5743.971280143573;5764.567657425626;5903.085021821625;870.851955167623;912.598456679059;925.9305552083621;977.7702239973601;1012.2205901455837;26482.47035059288;27672.169834904984;27687.307817304325;28088;28177.154685359474;909.9317551183688;950.3062764182048;963.5423173992438;1007.2848277722899;1047.9738006549896;12936.547220847226;13353.265570393722;13546.322683865767;13578;13727.382267797973;279231;281425;283727;283938;283972;47546.52453475421;48286.5171348282;48297.5170248293;48360.75819620879;48416;1048.5386429970788;1135.9034482069117;1226.3868065967017;1226.4297101847505;1237.2638280223252;24885.253442396755;27256.727432726213;27556.173314800588;27819.860900695367;27905.302367440978;38350.23299534049;38679;38885;38899.61100389073;38916.80541597274;204276;205209;205312;205499;205727;26689.466210676066;31299.84350078235;31751.142397184365;32293.192670183435;32348;35508.289834203686;36075;36239.63760362468;36476.81761591175;36677.63322366742;30847.691523084482;33205;33787;34178;34605.82697086498;33648.32703345968;33942.66057339395;34009;34144.317113658086;34374;33307.83346083254;33624;34158;34376.48435273523;34390.31219375548;29662.737098919533;32964.43043224106;34238.31523369469;35965.460518092776;36935.815320923226;24265.878670606533;24662.383440414134;24968.500629986935;25347.746522535275;25355.74644253534 10:42:00 INFO - PROCESS | 6765 | |2;jquery.html;352.20050485398144;356.5276009287694;357.26225344663277;366.569281094714;370.92210635766486;15217.847821521782;15625.765613515792;16943.830561694394;17307.39424120156;17332.393366232183;16351.446612571817;16784.244708988095;16786.74819877703;16797;16855.241514131863;4329.891752706184;5044.621653375993;5120.92318615221;5722.828315150552;5749.482546570829;5764.711764411783;5769.624974376652;5783.334916484595;5784.797532086378;5803.129530570406;5673.801416950408;5748.885022299552;5768.942310576904;5775.624584402021;5781.508571771384;5677.17680936264;5754.367019627837;5789.536837053047;5813.505852002585;5816;5024.799008039674;5082.822101226439;5114.130597798383;5165.535101840853;5172.5344718975475;19312.227510899545;19399.51501212467;19520.414387568395;19740.70388944167;19986.300479483292;1942.8639995200342;1993.7906519815501;2384.1059602649007;2453.4725034117573;2461.6430617560354;12698.555550555686;12756.362181890869;12820.23078615286;12853.421596028107;13137.737245255137;1730.1537527313571;1746.711792554227;1775.0947017021283;1791.408835084419;1805.8374746272898;40519.189616207805;59428.40571594272;62631.37368626301;62695.373046269866;63173;9295.256379489625;9385;9719.271054670928;9748;9792.265580081523;13276.800847987288;13328.800067998987;13355.866441335656;13360.532381366605;13419.798703019462;6912.827179320558;6934;7045.788626341218;7090.680919358641;7107;6630.403263706289;6690.899636505456;6791.558548694319;6806.149231346082;6843.520953533205;4115.42384066231;4230.682698797603;4241.257779888507;4244.448221731217;4323.502797178365;1684.519911825124;1734;1745.4327343613377;1745.9214335354939;1757.1829099468807;864.9610767515477;873.0963452826294;919.9724008279762;926.9953650231706;956.8564715292623;15668.373265069498;16126.919365403333;16215.918920405322;16236.350545978265;16711.415100471426;863.792689754467;867.5185272173878;873.1312344217545;946.6118891254553;949.6486300068881;9152.35933484663;9213.493257870881;9253;9624.51877406141;9632.181264592587;372839;375391;391961;394211;394249;51384.74307628438;56958;65089;69087.65456172687;69737;900.4507250577143;920.6133423961952;922.5894476957824;949.6106596295485;987.4174237200086;14312.57062288133;14429.639259018608;14477.927610362301;14753.704925901207;14970.47603333878;30479.390412191187;30598.84700576483;31084.222894426915;31354.05937821869;31943;42550.14899702051;43544.34683479814;45886;47256.7637161812;50045.49954500408;7501.212372701006;7590.354819840155;7649.808754781175;7655.808604784925;7800;7411.7035318588805;10011.349262297927;11048.889511104786;11869.406529673655;11915.40422978865;10412.947935260578;10422.322549034288;10540.156787456832;10832.891671083504;10908.963648453384;4926.5073492650445;8793.824123517366;10156.542955567165;10194.286399951932;10408.375497470177;10516;10662;10665.9466702666;10709.303895246783;10834.783304334027;7655.6937722490475;7692.499987501018;7693.730719425017;7750.457467977413;7814.804629884298;8830.735077947671;10148.188144948534;10311.484425778832;10523.947380263357;10613.257072005194 10:42:00 INFO - PROCESS | 6765 | |3;mootools.html;1308.136629824316;1448.855114488551;1457.2422340382998;1612.3389410341754;1804.7563578916843;6645.368689974451;7171.5338502997265;7297.197308296097;7344.339009489145;7365.926340736591;7389.5935723535185;7535.585542795144;7540.39676825854;7545.132309784376;7547.3584745296575;1942.300771722179;1987.1157334985937;1988.9502762430911;2246.618074927258;2279.122537822942;2249.6962910007187;2295.5753185660624;2299;2303.0672577606097;2309.1571576374586;2197.7362716474045;2203.3830527452337;2218.8446808723397;2221.855579387343;2273.954520909581;2235.9552808943813;2244.7306323241314;2246.067881829039;2246.84272100953;2247.1797793805226;2137.1237792505;2200.768919263486;2200.8899555022185;2206.9889650551804;2208.2712704807377;7662.9233707663325;7688.115866675348;7689.038870141232;7704;7708.0750309962605;4594.1730488512385;4708.364370809931;4710.481846996828;4722.1028004679;4730.834420795256;3162.8734850605947;3163.31988622445;3191.4095892260007;3222.629397619257;3258.5763850699495;999.3054826895311;1009.9899001009969;1016.9440680762555;1044.4725413666126;1078.4769386847372;10502.527386267637;10534.894651053468;10536.420496872668;10546.630867919586;10550.788984220273;4329.588689074596;4373.190959672471;4463.509014008457;4489.663275254369;4490.60791154743;8973.28213742899;8999.955000225087;9033.819323613623;9039.63841446348;9048.683296084606;4829.203181475017;4831.541003604652;4834.057358814997;4835.178019736653;4837.032593481318;3726.292004519187;4087.652549533323;4253.617174454314;4360.106178233455;4362.454693163355;3603.6936860367164;3639.6724294813594;3647.66860096063;3669.321175582526;3708.8145592720257;1225.4914210602678;1240.0761432732672;1241.6523373455448;1244.8319476870506;1255.9560415385417;942.241495596038;960;963.6723514005272;1007.561710655867;1202.4288462980014;7104.25405332443;7160.10498687664;7200.639968001579;7209.855802883913;7212.134543854771;449.13765570105477;450.5359479735877;453.605363333895;456.2631350369196;456.56170076726715;5392.838214853561;5421.566274698014;5453.836384908459;5462.426445223274;5486.286782718301;9282.396644218239;9634.566444510014;9644;9654.903450965401;9655.08276713711;9279.953600231956;9381.54586039165;9404.482753448488;9433.952830235805;9439.76400589977;7131.536450130829;7182.820429489305;7222.96388518054;7288.6720097595735;7289.08886389212;6740.595564266159;6742.898856517254;6781.287964763629;6799.490038247052;6799.660016999229;8249.79375515617;8346.833063338578;8414.242718155396;8466.703665371682;8482.533460659723;8485.109063548485;8570.48577085377;8579.099194584729;8583.785405364915;8698.043215246444;5682.346530149086;6027.78902738402;6180.721867515883;6773.559718618274;6849.24658287598;7129.7861064168155;7134.714611415485;7140.357367836712;7163.212046674966;7178.748743793943;6393.392627700361;6539.6403197824575;6545.181852268466;6648.5678430901835;6709.329067093252;6301.495880329654;6452.451541619015;6461.127747753993;6580.670966451754;6636.601803891782;6795.660216989032;6809.489288303496;6834.829129271808;6851.520393572601;6852.520323577502;6184.536159788124;6277.560570760185;6285.371462853678;6319.46284565817;6323;6257.937420625917;6339.112524246517;6339.651319177489;6359.427651511386;6384.042393640991 10:42:00 INFO - PROCESS | 6765 | |4;prototype.html;318.087090051552;322.1736246527658;324.1830586920961;324.482450491466;326.58360590247446;5332.120200166973;5392.379876314225;5422.024035673582;5443.265159203506;5451.454854514546;5319.946800531993;5336.43967383424;5354.625176237665;5360.115580929152;5369.677819330833;3949.4668219790246;4022.4971878515184;4105.322621767405;4157.937630935531;4173.499180098393;4129.339305711087;4130.669546436278;4158;4164.583541645827;4171.812268447927;4116.176764647068;4125.2780763366445;4127.484064491939;4137.751734895901;4141.6065473779945;3964.3062464068817;4056.9391459128137;4109.198706252252;4114.5679703630985;4132.896677583084;3634.7092232621326;3638.05410593245;3639.1811842335264;3644.489771432002;3648.890533284006;5038.445770965191;5053.747312634354;5063.569596584258;5133;5138.7173705446185;4836.298736683197;4837.612990960714;4842.951570484285;4851.51484851512;4853.830115945961;5634.323881134249;5636.323641163046;5643.830685079454;5653.9151912721345;5661.2357331760095;3964.2161027537436;4059.756414615103;4073.4704488416614;4080.3471444569022;4082.795860206978;5858.619189752652;5913.822585322448;5925.051991681354;5928.081147422156;5930.525557955353;4140.130572579732;4155.1897380010605;4155.8961025974595;4160.334346504545;4165.66674666026;4202.579742025773;4232.619064284229;4233.491980962242;4236.618704316565;4246.532881383046;4803.279508073747;4807.78364973577;4808.783604737795;4810.927836082462;4814.229723244264;5662.518685911661;5662.971685141631;5663.377028526858;5663.461971112738;5666.716664166775;1439.7048605035943;1468.860458256464;1493.4250313629113;1493.6713922936935;1496.2518740629685;942.7690215897012;972.8054389122062;988.2143695761887;1014.7412409835592;1017.9287449878437;4784.043191361672;4846.200376937766;4858.611311095104;4950.455449900508;4968.850934471971;5876.559258055663;5907.881842363215;5915.3788852170765;5917.142014407887;5919.55603329752;4986.077575648516;4986.127427700138;4997.225430058346;4998.2002879539095;5003.649744517848;3108.4404807134933;3139.262273365757;3154.1168472827644;3155.4477966356253;3163.7469002480207;5575.107982722745;5581.469760372758;5592.748326325243;5592.972035139798;5594.720263986866;5870.853228669317;6036.456718895321;6049.153118563405;6060.090986351995;6060.575759696779;5544.974179776754;5583.944160558423;5588.77644894216;5594.104943208986;5595.776168953278;5892.852678683067;5895.263092113486;5903.291605007426;5907.113932910098;5918.7928422505;5785.537157027344;5787.6816775076095;5794.82615521535;5796;5799.5070419014855;5342.465753424626;5581.944180558143;5582.051051321204;5592.245046918614;5601.355844077821;3969.0672691916798;4028.597140285948;4046.8785936421955;4052.149048699688;4053.695972801993;5873.765049397976;5885.47030767233;5893.263342082239;5952.464278214981;5957.434043765836;5684.175794509855;5686.488216060575;5686.601937864475;5696.088625819849;5697.3448053474385;5666.716664166693;5676.858078548069;5682.687452190004;5691.373948865538;5692.089265717465;5347.5721942243745;5537.1140617501005;5557.02752018387;5558.861028474159;5561.721913904208;5700.600957933071;5718.914216286842;5725.942740572541;5733.369329373849;5741.311042674905;5549.139883318092;5579.637323573955;5588.804391846266;5599.748011339581;5600.579956503197 10:42:00 INFO - PROCESS | 6765 | |5;yui.html;685.3797313431345;720.8053825467125;772.4438404348874;798.4730078148419;798.9800254993628;12538.623841284765;12607.747845043094;12713.36433178342;12719.10966232363;12725.936370318159;11997.22018068825;12010.099242556822;12048.39758012098;12066.758664826699;12078.516859325617;644.043595261037;786.4573444323427;812.5409143833745;813.0649752784316;813.1908750792969;809.6154326694802;816.5304949653943;816.6896579299857;817.2032268538157;818.3167055508658;686.8969654551807;858.3862538285125;859.0507489224411;859.70769938221;859.7893516088567;690.3683129936103;691.2361840166594;833.829065041665;850.1923172985627;852.5779739029158;625.6089943785134;626.7148447456397;628.0798630007016;628.5694299404922;629.1600713048086;12236.082293827909;12280.570180043656;12308.569200077955;12340.321282329469;12370.13409061357;11924.344161071138;12347.629571112791;12664.209148759726;12726.300053497054;12789.232646041268;9806.90193098074;9901.455419951899;10018;10027.448490333029;10149.391036537758;3384.6784555467193;3415.573053368329;3427.880024199166;3522.189896323834;3540.6459354064646;42402;42432.36351454731;42587.148257034685;42762.35856462156;43348;9747;9959.651412200537;9988.750281243027;9998.450085245382;10042.096211341015;17775.911120444314;17826.37607683725;17841.28634854617;18035.909820451077;18072.819271807377;6750.459963202932;6769.255381907986;6779.186497620317;6781.186257649114;7140.393066589294;3913.941290880639;3931.331673615492;3995.420664003703;4051.4530538376944;4056.006278461796;2907.0552070577146;2947.2337192330147;2952.734253917115;2955.054382597591;2989.9402011960074;535.028922505651;538.9571179767163;542.7747484793846;546.3798588601886;547.8931608336336;518.6602775182262;580.9738561764731;596.4989408896548;616.9383061693794;619.3434958943534;8243.134470880592;8364.330853531703;8543.316534677211;8555.443896146731;8583.656653733906;491.69514900761754;615.0374663651371;615.3784677475782;622.3931666625095;643.2088531106765;3584.8566057357934;3626.546681664792;3893.377059670439;3979.9403008954887;4037.8788636340955;45910;46735.76632116818;55233.171502427496;55879.44120558743;56031.71984140053;42362.788186059486;43343.13313733708;43639;43759.562404376185;44045;40070.39894401586;40335.59664403318;40448.19103617911;40450.79774601167;40516.594834051284;8650.783730406538;8661.437006594551;8759.343049271203;8815.691450799448;8878.955605221932;30500.237494062825;31014.844925775225;31860;32099.839500802347;33042;36332;38700.612993870825;39081.80459097686;39165.608343916196;39228.803855980535;10200.540975655966;10205.336653117523;10366.222533309881;10680.8931910683;10902.400367979837;12166.330851802883;12172.39138043112;12219.327936963553;12334;12938.935305323414;8778.466258890976;10689.251752377259;11458.713532161762;11842.763144736884;11871.643850684493;10414.47927603632;10516.684499464722;10624.946875265574;10647.787044258917;10652.680419587425;10812.405317707287;10976.121910247002;11053.115750740082;11058.170637202082;11139.610113645984;9308.95345523268;9396.15434610861;9638.9036109638;9812.901870981199;10115.898841011496;9554.474503902353;9569.952150239204;9619.086186812241;9633.759156021155;9697.22422206236 10:42:00 INFO - PROCESS | 6765 | __end_tp_report 10:42:00 INFO - PROCESS | 6765 | __start_cc_report 10:42:00 INFO - PROCESS | 6765 | _x_x_mozilla_cycle_collect,892 10:42:00 INFO - PROCESS | 6765 | __end_cc_report 10:42:00 INFO - PROCESS | 6765 | __startTimestamp1458927720187__endTimestamp 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - PROCESS | 6765 | ------- Summary: start ------- 10:42:00 INFO - PROCESS | 6765 | Number of tests: 6 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - PROCESS | 6765 | [#0] dojo.html Cycles:165 Average:4642.52 Median:4798.85 stddev:471.82 (9.8%) stddev-sans-first:445.77 10:42:00 INFO - PROCESS | 6765 | Values: 2619.3 2717.0 2723.3 2724.6 2765.2 4566.7 4675.5 4679.8 4690.1 4698.1 4641.6 4680.6 4681.4 4691.6 4786.3 4168.7 4271.9 4300.0 4309.8 4419.2 4227.5 4341.7 4364.9 4396.3 4399.8 4259.2 4290.5 4330.4 4330.9 4338.2 4281.3 4287.7 4300.1 4324.5 4333.7 4197.5 4267.2 4267.7 4297.2 4314.1 4553.6 4573.2 4578.4 4595.1 4637.7 5018.8 5028.3 5030.6 5038.2 5079.3 4917.8 5040.2 5061.8 5062.5 5069.5 4717.3 4726.9 4735.9 4751.6 4774.8 5152.3 5154.4 5158.4 5165.7 5175.9 4873.3 4926.1 4953.9 4985.3 5001.3 5004.0 5021.6 5031.0 5031.6 5040.1 4980.5 4988.6 4989.2 4991.4 5026.2 4866.6 5002.4 5013.3 5064.5 5078.5 4254.5 4262.1 4279.7 4283.0 4327.1 3758.1 3761.0 3766.5 3779.6 3793.3 4233.6 4248.5 4299.5 4312.8 4329.2 4996.2 5051.1 5069.9 5076.2 5087.6 4368.5 4377.8 4380.2 4381.3 4427.4 4457.5 4521.7 4560.5 4589.7 4605.3 4739.3 4744.0 4787.8 4789.8 4844.5 4896.8 5024.8 5030.2 5036.8 5093.6 4730.6 4797.3 4798.8 4812.3 4839.2 4856.8 4861.5 4864.6 4865.4 4909.4 4922.2 4923.7 4938.7 4971.0 4988.4 4868.4 4883.1 4884.0 4885.3 4935.5 4888.4 4889.6 4896.1 4898.4 4933.0 4719.6 4813.0 4822.1 4861.2 4875.7 4873.3 4897.4 4911.4 4923.0 4940.0 4806.4 4808.1 4808.2 4814.3 4844.8 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - PROCESS | 6765 | [#1] ext.html Cycles:180 Average:39766.07 Median:34746.57 stddev:63707.31 (183.3%) stddev-sans-first:63817.89 10:42:00 INFO - PROCESS | 6765 | Values: 523.3 537.1 542.0 562.9 576.0 27056.2 27464.6 34318.5 34734.8 34758.3 37972.4 38092.6 38334.2 38472.2 38503.8 7527.1 7701.7 7704.0 7715.2 7720.0 7623.7 7722.8 7738.9 7754.0 7759.1 7914.1 7980.8 7986.2 7987.2 8004.9 7853.4 7903.1 7967.4 7970.5 7973.4 7707.8 7897.0 7904.8 7911.0 7918.2 35283.6 35567.0 35632.5 35666.0 35717.1 3076.4 3247.1 3310.0 3404.1 3513.0 29168.4 29746.7 30056.8 30169.7 30758.5 3447.9 3455.6 3484.3 3502.3 3551.5 238295.0 239852.8 239943.0 239947.0 239955.0 42263.6 54600.5 54671.5 54980.0 55016.5 40794.8 41147.8 41151.8 41176.4 41197.2 12864.6 13068.5 13071.2 13072.3 13078.9 9825.9 9913.9 9913.9 9919.7 9994.1 14700.9 14790.8 14793.6 14842.3 14934.9 5514.6 5730.9 5744.0 5764.6 5903.1 870.9 912.6 925.9 977.8 1012.2 26482.5 27672.2 27687.3 28088.0 28177.2 909.9 950.3 963.5 1007.3 1048.0 12936.5 13353.3 13546.3 13578.0 13727.4 279231.0 281425.0 283727.0 283938.0 283972.0 47546.5 48286.5 48297.5 48360.8 48416.0 1048.5 1135.9 1226.4 1226.4 1237.3 24885.3 27256.7 27556.2 27819.9 27905.3 38350.2 38679.0 38885.0 38899.6 38916.8 204276.0 205209.0 205312.0 205499.0 205727.0 26689.5 31299.8 31751.1 32293.2 32348.0 35508.3 36075.0 36239.6 36476.8 36677.6 30847.7 33205.0 33787.0 34178.0 34605.8 33648.3 33942.7 34009.0 34144.3 34374.0 33307.8 33624.0 34158.0 34376.5 34390.3 29662.7 32964.4 34238.3 35965.5 36935.8 24265.9 24662.4 24968.5 25347.7 25355.7 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - PROCESS | 6765 | [#2] jquery.html Cycles:180 Average:23114.32 Median:23397.30 stddev:63186.78 (270.1%) stddev-sans-first:63340.92 10:42:00 INFO - PROCESS | 6765 | Values: 352.2 356.5 357.3 366.6 370.9 15217.8 15625.8 16943.8 17307.4 17332.4 16351.4 16784.2 16786.7 16797.0 16855.2 4329.9 5044.6 5120.9 5722.8 5749.5 5764.7 5769.6 5783.3 5784.8 5803.1 5673.8 5748.9 5768.9 5775.6 5781.5 5677.2 5754.4 5789.5 5813.5 5816.0 5024.8 5082.8 5114.1 5165.5 5172.5 19312.2 19399.5 19520.4 19740.7 19986.3 1942.9 1993.8 2384.1 2453.5 2461.6 12698.6 12756.4 12820.2 12853.4 13137.7 1730.2 1746.7 1775.1 1791.4 1805.8 40519.2 59428.4 62631.4 62695.4 63173.0 9295.3 9385.0 9719.3 9748.0 9792.3 13276.8 13328.8 13355.9 13360.5 13419.8 6912.8 6934.0 7045.8 7090.7 7107.0 6630.4 6690.9 6791.6 6806.1 6843.5 4115.4 4230.7 4241.3 4244.4 4323.5 1684.5 1734.0 1745.4 1745.9 1757.2 865.0 873.1 920.0 927.0 956.9 15668.4 16126.9 16215.9 16236.4 16711.4 863.8 867.5 873.1 946.6 949.6 9152.4 9213.5 9253.0 9624.5 9632.2 372839.0 375391.0 391961.0 394211.0 394249.0 51384.7 56958.0 65089.0 69087.7 69737.0 900.5 920.6 922.6 949.6 987.4 14312.6 14429.6 14477.9 14753.7 14970.5 30479.4 30598.8 31084.2 31354.1 31943.0 42550.1 43544.3 45886.0 47256.8 50045.5 7501.2 7590.4 7649.8 7655.8 7800.0 7411.7 10011.3 11048.9 11869.4 11915.4 10412.9 10422.3 10540.2 10832.9 10909.0 4926.5 8793.8 10156.5 10194.3 10408.4 10516.0 10662.0 10665.9 10709.3 10834.8 7655.7 7692.5 7693.7 7750.5 7814.8 8830.7 10148.2 10311.5 10523.9 10613.3 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - PROCESS | 6765 | [#3] mootools.html Cycles:180 Average:5324.85 Median:6267.75 stddev:2800.18 (44.7%) stddev-sans-first:2791.76 10:42:00 INFO - PROCESS | 6765 | Values: 1308.1 1448.9 1457.2 1612.3 1804.8 6645.4 7171.5 7297.2 7344.3 7365.9 7389.6 7535.6 7540.4 7545.1 7547.4 1942.3 1987.1 1989.0 2246.6 2279.1 2249.7 2295.6 2299.0 2303.1 2309.2 2197.7 2203.4 2218.8 2221.9 2274.0 2236.0 2244.7 2246.1 2246.8 2247.2 2137.1 2200.8 2200.9 2207.0 2208.3 7662.9 7688.1 7689.0 7704.0 7708.1 4594.2 4708.4 4710.5 4722.1 4730.8 3162.9 3163.3 3191.4 3222.6 3258.6 999.3 1010.0 1016.9 1044.5 1078.5 10502.5 10534.9 10536.4 10546.6 10550.8 4329.6 4373.2 4463.5 4489.7 4490.6 8973.3 9000.0 9033.8 9039.6 9048.7 4829.2 4831.5 4834.1 4835.2 4837.0 3726.3 4087.7 4253.6 4360.1 4362.5 3603.7 3639.7 3647.7 3669.3 3708.8 1225.5 1240.1 1241.7 1244.8 1256.0 942.2 960.0 963.7 1007.6 1202.4 7104.3 7160.1 7200.6 7209.9 7212.1 449.1 450.5 453.6 456.3 456.6 5392.8 5421.6 5453.8 5462.4 5486.3 9282.4 9634.6 9644.0 9654.9 9655.1 9280.0 9381.5 9404.5 9434.0 9439.8 7131.5 7182.8 7223.0 7288.7 7289.1 6740.6 6742.9 6781.3 6799.5 6799.7 8249.8 8346.8 8414.2 8466.7 8482.5 8485.1 8570.5 8579.1 8583.8 8698.0 5682.3 6027.8 6180.7 6773.6 6849.2 7129.8 7134.7 7140.4 7163.2 7178.7 6393.4 6539.6 6545.2 6648.6 6709.3 6301.5 6452.5 6461.1 6580.7 6636.6 6795.7 6809.5 6834.8 6851.5 6852.5 6184.5 6277.6 6285.4 6319.5 6323.0 6257.9 6339.1 6339.7 6359.4 6384.0 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - PROCESS | 6765 | [#4] prototype.html Cycles:180 Average:4708.46 Median:5345.02 stddev:1380.36 (25.8%) stddev-sans-first:1344.32 10:42:00 INFO - PROCESS | 6765 | Values: 318.1 322.2 324.2 324.5 326.6 5332.1 5392.4 5422.0 5443.3 5451.5 5319.9 5336.4 5354.6 5360.1 5369.7 3949.5 4022.5 4105.3 4157.9 4173.5 4129.3 4130.7 4158.0 4164.6 4171.8 4116.2 4125.3 4127.5 4137.8 4141.6 3964.3 4056.9 4109.2 4114.6 4132.9 3634.7 3638.1 3639.2 3644.5 3648.9 5038.4 5053.7 5063.6 5133.0 5138.7 4836.3 4837.6 4843.0 4851.5 4853.8 5634.3 5636.3 5643.8 5653.9 5661.2 3964.2 4059.8 4073.5 4080.3 4082.8 5858.6 5913.8 5925.1 5928.1 5930.5 4140.1 4155.2 4155.9 4160.3 4165.7 4202.6 4232.6 4233.5 4236.6 4246.5 4803.3 4807.8 4808.8 4810.9 4814.2 5662.5 5663.0 5663.4 5663.5 5666.7 1439.7 1468.9 1493.4 1493.7 1496.3 942.8 972.8 988.2 1014.7 1017.9 4784.0 4846.2 4858.6 4950.5 4968.9 5876.6 5907.9 5915.4 5917.1 5919.6 4986.1 4986.1 4997.2 4998.2 5003.6 3108.4 3139.3 3154.1 3155.4 3163.7 5575.1 5581.5 5592.7 5593.0 5594.7 5870.9 6036.5 6049.2 6060.1 6060.6 5545.0 5583.9 5588.8 5594.1 5595.8 5892.9 5895.3 5903.3 5907.1 5918.8 5785.5 5787.7 5794.8 5796.0 5799.5 5342.5 5581.9 5582.1 5592.2 5601.4 3969.1 4028.6 4046.9 4052.1 4053.7 5873.8 5885.5 5893.3 5952.5 5957.4 5684.2 5686.5 5686.6 5696.1 5697.3 5666.7 5676.9 5682.7 5691.4 5692.1 5347.6 5537.1 5557.0 5558.9 5561.7 5700.6 5718.9 5725.9 5733.4 5741.3 5549.1 5579.6 5588.8 5599.7 5600.6 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - PROCESS | 6765 | [#5] yui.html Cycles:180 Average:12644.44 Median:42417.18 stddev:13962.92 (32.9%) stddev-sans-first:13973.20 10:42:00 INFO - PROCESS | 6765 | Values: 685.4 720.8 772.4 798.5 799.0 12538.6 12607.7 12713.4 12719.1 12725.9 11997.2 12010.1 12048.4 12066.8 12078.5 644.0 786.5 812.5 813.1 813.2 809.6 816.5 816.7 817.2 818.3 686.9 858.4 859.1 859.7 859.8 690.4 691.2 833.8 850.2 852.6 625.6 626.7 628.1 628.6 629.2 12236.1 12280.6 12308.6 12340.3 12370.1 11924.3 12347.6 12664.2 12726.3 12789.2 9806.9 9901.5 10018.0 10027.4 10149.4 3384.7 3415.6 3427.9 3522.2 3540.6 42402.0 42432.4 42587.1 42762.4 43348.0 9747.0 9959.7 9988.8 9998.5 10042.1 17775.9 17826.4 17841.3 18035.9 18072.8 6750.5 6769.3 6779.2 6781.2 7140.4 3913.9 3931.3 3995.4 4051.5 4056.0 2907.1 2947.2 2952.7 2955.1 2989.9 535.0 539.0 542.8 546.4 547.9 518.7 581.0 596.5 616.9 619.3 8243.1 8364.3 8543.3 8555.4 8583.7 491.7 615.0 615.4 622.4 643.2 3584.9 3626.5 3893.4 3979.9 4037.9 45910.0 46735.8 55233.2 55879.4 56031.7 42362.8 43343.1 43639.0 43759.6 44045.0 40070.4 40335.6 40448.2 40450.8 40516.6 8650.8 8661.4 8759.3 8815.7 8879.0 30500.2 31014.8 31860.0 32099.8 33042.0 36332.0 38700.6 39081.8 39165.6 39228.8 10200.5 10205.3 10366.2 10680.9 10902.4 12166.3 12172.4 12219.3 12334.0 12938.9 8778.5 10689.3 11458.7 11842.8 11871.6 10414.5 10516.7 10624.9 10647.8 10652.7 10812.4 10976.1 11053.1 11058.2 11139.6 9309.0 9396.2 9638.9 9812.9 10115.9 9554.5 9570.0 9619.1 9633.8 9697.2 10:42:00 INFO - PROCESS | 6765 | -------- Summary: end -------- 10:42:00 INFO - PROCESS | 6765 | 10:42:00 INFO - TEST-INFO | 6765: exit 0 10:42:00 INFO - TEST-OK | dromaeo_css | took 1116410ms 10:42:00 INFO - TEST-START | kraken 10:42:00 INFO - operating with platform_type : linux_ 10:42:00 INFO - Initialising browser for kraken test... 10:42:00 INFO - TEST-INFO | started process 6942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdG4a7n/profile http://localhost:51002/getInfo.html) 10:42:05 INFO - PROCESS | 6942 | __metrics Screen width/height:1600/1200 10:42:05 INFO - PROCESS | 6942 | colorDepth:24 10:42:05 INFO - PROCESS | 6942 | Browser inner width/height: 1024/697 10:42:05 INFO - PROCESS | 6942 | __metrics 10:42:06 ERROR - PROCESS | 6942 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:42:06 INFO - PROCESS | 6942 | 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. 10:42:07 INFO - TEST-INFO | 6942: exit 0 10:42:07 INFO - Browser initialized. 10:42:07 INFO - Running cycle 1/1 for kraken test... 10:42:07 INFO - TEST-INFO | started process 7026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdG4a7n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:42:19 INFO - PROCESS | 7026 | RSS: Main: 155136000 10:42:19 INFO - PROCESS | 7026 | 10:42:22 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51002/tests/kraken/driver.html?testName=audio-beat-detection) 10:42:22 INFO - PROCESS | 7026 | RSS: Main: 195457024 10:42:22 INFO - PROCESS | 7026 | 10:42:25 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51002/tests/kraken/driver.html?testName=audio-dft) 10:42:26 INFO - PROCESS | 7026 | RSS: Main: 185053184 10:42:26 INFO - PROCESS | 7026 | 10:42:29 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51002/tests/kraken/driver.html?testName=audio-fft) 10:42:29 INFO - PROCESS | 7026 | RSS: Main: 171171840 10:42:29 INFO - PROCESS | 7026 | 10:42:31 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51002/tests/kraken/driver.html?testName=audio-oscillator) 10:42:32 INFO - PROCESS | 7026 | RSS: Main: 172204032 10:42:32 INFO - PROCESS | 7026 | 10:42:34 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51002/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:42:35 INFO - PROCESS | 7026 | RSS: Main: 174010368 10:42:35 INFO - PROCESS | 7026 | 10:42:38 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51002/tests/kraken/driver.html?testName=imaging-darkroom) 10:42:38 INFO - PROCESS | 7026 | RSS: Main: 174854144 10:42:38 INFO - PROCESS | 7026 | 10:42:42 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51002/tests/kraken/driver.html?testName=imaging-desaturate) 10:42:42 INFO - PROCESS | 7026 | RSS: Main: 175185920 10:42:42 INFO - PROCESS | 7026 | 10:42:45 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51002/tests/kraken/driver.html?testName=json-parse-financial) 10:42:46 INFO - PROCESS | 7026 | RSS: Main: 174731264 10:42:46 INFO - PROCESS | 7026 | 10:42:48 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51002/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:42:48 INFO - PROCESS | 7026 | RSS: Main: 187453440 10:42:48 INFO - PROCESS | 7026 | 10:42:50 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51002/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:42:51 INFO - PROCESS | 7026 | RSS: Main: 185638912 10:42:51 INFO - PROCESS | 7026 | 10:42:53 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51002/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:42:53 INFO - PROCESS | 7026 | RSS: Main: 193990656 10:42:53 INFO - PROCESS | 7026 | 10:42:56 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51002/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:42:56 INFO - PROCESS | 7026 | RSS: Main: 199225344 10:42:56 INFO - PROCESS | 7026 | 10:42:59 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51002/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:43:00 INFO - PROCESS | 7026 | RSS: Main: 199286784 10:43:00 INFO - PROCESS | 7026 | 10:43:01 INFO - PROCESS | 7026 | Cycle 1(1): loaded http://localhost:51002/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51002/tests/kraken/driver.html?testName=ai-astar) 10:43:02 INFO - PROCESS | 7026 | RSS: Main: 260919296 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | __start_tp_report 10:43:02 INFO - PROCESS | 7026 | _x_x_mozilla_page_load 10:43:02 INFO - PROCESS | 7026 | _x_x_mozilla_page_load_details 10:43:02 INFO - PROCESS | 7026 | |i|pagename|runs| 10:43:02 INFO - PROCESS | 7026 | |0;ai-astar;112;114;108;111;113;112;103;112;112;113 10:43:02 INFO - PROCESS | 7026 | |1;audio-beat-detection;157;130;159;197;133;166;157;134;175;130 10:43:02 INFO - PROCESS | 7026 | |2;audio-dft;162;163;162;162;161;161;162;162;163;162 10:43:02 INFO - PROCESS | 7026 | |3;audio-fft;73;74;124;108;74;77;75;133;101;77 10:43:02 INFO - PROCESS | 7026 | |4;audio-oscillator;94;95;133;93;93;93;146;93;93;133 10:43:02 INFO - PROCESS | 7026 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 10:43:02 INFO - PROCESS | 7026 | |6;imaging-darkroom;145;147;146;145;146;145;145;145;145;145 10:43:02 INFO - PROCESS | 7026 | |7;imaging-desaturate;96;95;96;96;95;95;95;96;95;95 10:43:02 INFO - PROCESS | 7026 | |8;json-parse-financial;65;65;64;65;63;63;64;72;61;62 10:43:02 INFO - PROCESS | 7026 | |9;json-stringify-tinderbox;64;65;64;65;65;65;64;64;65;64 10:43:02 INFO - PROCESS | 7026 | |10;stanford-crypto-aes;81;83;82;84;90;85;81;81;82;89 10:43:02 INFO - PROCESS | 7026 | |11;stanford-crypto-ccm;118;118;118;122;114;118;123;126;120;119 10:43:02 INFO - PROCESS | 7026 | |12;stanford-crypto-pbkdf2;144;142;142;145;148;136;145;137;138;144 10:43:02 INFO - PROCESS | 7026 | |13;stanford-crypto-sha256-iterative;70;67;67;69;70;72;68;66;66;66 10:43:02 INFO - PROCESS | 7026 | __end_tp_report 10:43:02 INFO - PROCESS | 7026 | __start_cc_report 10:43:02 INFO - PROCESS | 7026 | _x_x_mozilla_cycle_collect,1169 10:43:02 INFO - PROCESS | 7026 | __end_cc_report 10:43:02 INFO - PROCESS | 7026 | __startTimestamp1458927782118__endTimestamp 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | ------- Summary: start ------- 10:43:02 INFO - PROCESS | 7026 | Number of tests: 14 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.23 (2.9%) stddev-sans-first:3.41 10:43:02 INFO - PROCESS | 7026 | Values: 112.0 114.0 108.0 111.0 113.0 112.0 103.0 112.0 112.0 113.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:158.00 stddev:22.29 (14.1%) stddev-sans-first:23.61 10:43:02 INFO - PROCESS | 7026 | Values: 157.0 130.0 159.0 197.0 133.0 166.0 157.0 134.0 175.0 130.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 10:43:02 INFO - PROCESS | 7026 | Values: 162.0 163.0 162.0 162.0 161.0 161.0 162.0 162.0 163.0 162.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#3] audio-fft Cycles:10 Average:91.60 Median:74.00 stddev:23.07 (31.2%) stddev-sans-first:23.46 10:43:02 INFO - PROCESS | 7026 | Values: 73.0 74.0 124.0 108.0 74.0 77.0 75.0 133.0 101.0 77.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:21.51 (23.1%) stddev-sans-first:22.33 10:43:02 INFO - PROCESS | 7026 | Values: 94.0 95.0 133.0 93.0 93.0 93.0 146.0 93.0 93.0 133.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:43:02 INFO - PROCESS | 7026 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:43:02 INFO - PROCESS | 7026 | Values: 145.0 147.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:43:02 INFO - PROCESS | 7026 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:2.99 (4.6%) stddev-sans-first:3.16 10:43:02 INFO - PROCESS | 7026 | Values: 65.0 65.0 64.0 65.0 63.0 63.0 64.0 72.0 61.0 62.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:43:02 INFO - PROCESS | 7026 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 64.0 64.0 65.0 64.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:3.29 (3.9%) stddev-sans-first:3.33 10:43:02 INFO - PROCESS | 7026 | Values: 81.0 83.0 82.0 84.0 90.0 85.0 81.0 81.0 82.0 89.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.50 stddev:3.34 (2.8%) stddev-sans-first:3.49 10:43:02 INFO - PROCESS | 7026 | Values: 118.0 118.0 118.0 122.0 114.0 118.0 123.0 126.0 120.0 119.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.10 Median:144.00 stddev:3.93 (2.7%) stddev-sans-first:4.11 10:43:02 INFO - PROCESS | 7026 | Values: 144.0 142.0 142.0 145.0 148.0 136.0 145.0 137.0 138.0 144.0 10:43:02 INFO - PROCESS | 7026 | 10:43:02 INFO - PROCESS | 7026 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:2.08 (3.0%) stddev-sans-first:2.09 10:43:02 INFO - PROCESS | 7026 | Values: 70.0 67.0 67.0 69.0 70.0 72.0 68.0 66.0 66.0 66.0 10:43:02 INFO - PROCESS | 7026 | -------- Summary: end -------- 10:43:02 INFO - PROCESS | 7026 | 10:43:03 INFO - TEST-INFO | 7026: exit 0 10:43:03 INFO - TEST-OK | kraken | took 62239ms 10:43:03 INFO - SUITE-END | took 1178s 10:43:03 INFO - Completed test suite (00:19:38) 10:43:03 INFO - javascript benchmark 10:43:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2619.266605350502, 2717.0, 2723.305557082946, 2724.5776904579784, 2765.2119146043374, 4566.725996440207, 4675.532446755327, 4679.8362057328, 4690.06198760248, 4698.08387364464, 4641.582257596816, 4680.555347242007, 4681.4382274127065, 4691.648126390517, 4786.258129989848, 4168.7081904266715, 4271.9359209611885, 4299.978500107503, 4309.784510774464, 4419.160359531695, 4227.513835908864, 4341.739495630257, 4364.869053928387, 4396.296592545194, 4399.846005389812, 4259.190753756808, 4290.528041915387, 4330.350447432878, 4330.935035974463, 4338.2191205582985, 4281.336392859112, 4287.656987440997, 4300.053988122608, 4324.459442569679, 4333.653307735373, 4197.517285512175, 4267.174285912585, 4267.701260911737, 4297.226499230137, 4314.072474417983, 4553.590176884097, 4573.245414506602, 4578.427696537933, 4595.080983803219, 4637.744924029177, 5018.77415516299, 5028.296038554606, 5030.622703297231, 5038.2190760432195, 5079.314292570492, 4917.7786999585105, 5040.16837221858, 5061.772220250097, 5062.544371006627, 5069.518395752398, 4717.339572459859, 4726.929096063562, 4735.928961065587, 4751.59611433032, 4774.809007639725, 5152.27868098459, 5154.407243167008, 5158.4067832199025, 5165.664231824994, 5175.870603234874, 4873.293372460973, 4926.1379258629595, 4953.851384458472, 4985.302057711923, 5001.299818025479, 5003.974980125076, 5021.623378246573, 5030.974845125751, 5031.647784655112, 5040.067587496325, 4980.477049909779, 4988.575971042429, 4989.226669866177, 4991.3511243538105, 5026.195808670668, 4866.562009419169, 5002.374703162105, 5013.323201367842, 5064.468230835783, 5078.466760990117, 4254.532001479834, 4262.147570485915, 4279.743215407086, 4282.9785851071165, 4327.069680018811, 3758.0792705787258, 3761.0033341164612, 3766.5291838520184, 3779.60314167014, 3793.279276937373, 4233.618974292329, 4248.4901811782165, 4299.54854740254, 4312.805923733439, 4329.242382583036, 4996.15065438869, 5051.116054690415, 5069.923951140736, 5076.18780995039, 5087.567556757717, 4368.541303163186, 4377.781110944504, 4380.233459144637, 4381.255186618282, 4427.40230068943, 4457.531959144308, 4521.706089104264, 4560.543945605413, 4589.655775816827, 4605.309203619417, 4739.289106634033, 4743.952560474351, 4787.784549695341, 4789.808407663654, 4844.515548445127, 4896.804127834989, 5024.824131155392, 5030.220315851049, 5036.823711170092, 5093.567046801063, 4730.6215502759005, 4797.304390863375, 4798.848276413705, 4812.326274321527, 4839.201531747222, 4856.78144483492, 4861.51384861511, 4864.610831133572, 4865.367502224688, 4909.361782968192, 4922.163232250455, 4923.655344125877, 4938.703677779345, 4971.0, 4988.4263309719845, 4868.440129385024, 4883.121038213014, 4884.0, 4885.267209918541, 4935.531124543163, 4888.413390393175, 4889.559939605452, 4896.11869863428, 4898.4121905371585, 4933.0, 4719.551642593948, 4813.0, 4822.059698358787, 4861.1979023462145, 4875.658703890694, 4873.317735516959, 4897.363342765418, 4911.386076740408, 4923.0, 4940.036692844861, 4806.447258565309, 4808.08646357191, 4808.230683090689, 4814.277858321279, 4844.806207751651], "unit": "score", "name": "dojo.html", "value": 4613.759547870921}, {"lowerIsBetter": false, "replicates": [523.2857149990265, 537.0842713174038, 542.035177384256, 562.8714427572718, 575.9596828222024, 27056.188314350577, 27464.588031179548, 34318.485222721676, 34734.8263258684, 34758.30483390337, 37972.43041354382, 38092.619073809255, 38334.233315333746, 38472.230555388946, 38503.80748096263, 7527.13437954634, 7701.653425595861, 7703.961480192591, 7715.228477152296, 7719.961400192991, 7623.695052197905, 7722.806929826743, 7738.883916741253, 7753.961230193841, 7759.107702614187, 7914.089879663855, 7980.8403831923615, 7986.2413070758475, 7987.201279871995, 8004.879926801103, 7853.371730261565, 7903.051633803922, 7967.402444816633, 7970.4819186752675, 7973.362131029504, 7707.845843083107, 7897.0, 7904.762857114296, 7911.0, 7918.168592297783, 35283.647163528294, 35567.0, 35632.46551301733, 35666.0, 35717.10707232314, 3076.446239676857, 3247.0745837436452, 3309.9503507447407, 3404.0808981574837, 3512.982435087834, 29168.41663166746, 29746.70253297461, 30056.8497157515, 30169.698303016907, 30758.53862192069, 3447.879324223665, 3455.6026057003514, 3484.337975784593, 3502.3345564342694, 3551.4672799080085, 238295.0, 239852.80073599695, 239943.0, 239947.0, 239955.0, 42263.57736422658, 54600.45399545954, 54671.45328546743, 54980.0, 55016.524256407756, 40794.796026020274, 41147.7942610285, 41151.7942410292, 41176.38235426471, 41197.1760564793, 12864.614061578168, 13068.477260909647, 13071.15037522558, 13072.281024543741, 13078.869211307765, 9825.9017409825, 9913.900860991442, 9913.900860991442, 9919.702408927744, 9994.050565196294, 14700.926495367456, 14790.778138327934, 14793.556193314218, 14842.257887105601, 14934.925325373304, 5514.558835293167, 5730.856728581735, 5743.971280143573, 5764.567657425626, 5903.085021821625, 870.851955167623, 912.598456679059, 925.9305552083621, 977.7702239973601, 1012.2205901455837, 26482.47035059288, 27672.169834904984, 27687.307817304325, 28088.0, 28177.154685359474, 909.9317551183688, 950.3062764182048, 963.5423173992438, 1007.2848277722899, 1047.9738006549896, 12936.547220847226, 13353.265570393722, 13546.322683865767, 13578.0, 13727.382267797973, 279231.0, 281425.0, 283727.0, 283938.0, 283972.0, 47546.52453475421, 48286.5171348282, 48297.5170248293, 48360.75819620879, 48416.0, 1048.5386429970788, 1135.9034482069117, 1226.3868065967017, 1226.4297101847505, 1237.2638280223252, 24885.253442396755, 27256.727432726213, 27556.173314800588, 27819.860900695367, 27905.302367440978, 38350.23299534049, 38679.0, 38885.0, 38899.61100389073, 38916.80541597274, 204276.0, 205209.0, 205312.0, 205499.0, 205727.0, 26689.466210676066, 31299.84350078235, 31751.142397184365, 32293.192670183435, 32348.0, 35508.289834203686, 36075.0, 36239.63760362468, 36476.81761591175, 36677.63322366742, 30847.691523084482, 33205.0, 33787.0, 34178.0, 34605.82697086498, 33648.32703345968, 33942.66057339395, 34009.0, 34144.317113658086, 34374.0, 33307.83346083254, 33624.0, 34158.0, 34376.48435273523, 34390.31219375548, 29662.737098919533, 32964.43043224106, 34238.31523369469, 35965.460518092776, 36935.815320923226, 24265.878670606533, 24662.383440414134, 24968.500629986935, 25347.746522535275, 25355.74644253534], "unit": "score", "name": "ext.html", "value": 16433.811922130506}, {"lowerIsBetter": false, "replicates": [352.20050485398144, 356.5276009287694, 357.26225344663277, 366.569281094714, 370.92210635766486, 15217.847821521782, 15625.765613515792, 16943.830561694394, 17307.39424120156, 17332.393366232183, 16351.446612571817, 16784.244708988095, 16786.74819877703, 16797.0, 16855.241514131863, 4329.891752706184, 5044.621653375993, 5120.92318615221, 5722.828315150552, 5749.482546570829, 5764.711764411783, 5769.624974376652, 5783.334916484595, 5784.797532086378, 5803.129530570406, 5673.801416950408, 5748.885022299552, 5768.942310576904, 5775.624584402021, 5781.508571771384, 5677.17680936264, 5754.367019627837, 5789.536837053047, 5813.505852002585, 5816.0, 5024.799008039674, 5082.822101226439, 5114.130597798383, 5165.535101840853, 5172.5344718975475, 19312.227510899545, 19399.51501212467, 19520.414387568395, 19740.70388944167, 19986.300479483292, 1942.8639995200342, 1993.7906519815501, 2384.1059602649007, 2453.4725034117573, 2461.6430617560354, 12698.555550555686, 12756.362181890869, 12820.23078615286, 12853.421596028107, 13137.737245255137, 1730.1537527313571, 1746.711792554227, 1775.0947017021283, 1791.408835084419, 1805.8374746272898, 40519.189616207805, 59428.40571594272, 62631.37368626301, 62695.373046269866, 63173.0, 9295.256379489625, 9385.0, 9719.271054670928, 9748.0, 9792.265580081523, 13276.800847987288, 13328.800067998987, 13355.866441335656, 13360.532381366605, 13419.798703019462, 6912.827179320558, 6934.0, 7045.788626341218, 7090.680919358641, 7107.0, 6630.403263706289, 6690.899636505456, 6791.558548694319, 6806.149231346082, 6843.520953533205, 4115.42384066231, 4230.682698797603, 4241.257779888507, 4244.448221731217, 4323.502797178365, 1684.519911825124, 1734.0, 1745.4327343613377, 1745.9214335354939, 1757.1829099468807, 864.9610767515477, 873.0963452826294, 919.9724008279762, 926.9953650231706, 956.8564715292623, 15668.373265069498, 16126.919365403333, 16215.918920405322, 16236.350545978265, 16711.415100471426, 863.792689754467, 867.5185272173878, 873.1312344217545, 946.6118891254553, 949.6486300068881, 9152.35933484663, 9213.493257870881, 9253.0, 9624.51877406141, 9632.181264592587, 372839.0, 375391.0, 391961.0, 394211.0, 394249.0, 51384.74307628438, 56958.0, 65089.0, 69087.65456172687, 69737.0, 900.4507250577143, 920.6133423961952, 922.5894476957824, 949.6106596295485, 987.4174237200086, 14312.57062288133, 14429.639259018608, 14477.927610362301, 14753.704925901207, 14970.47603333878, 30479.390412191187, 30598.84700576483, 31084.222894426915, 31354.05937821869, 31943.0, 42550.14899702051, 43544.34683479814, 45886.0, 47256.7637161812, 50045.49954500408, 7501.212372701006, 7590.354819840155, 7649.808754781175, 7655.808604784925, 7800.0, 7411.7035318588805, 10011.349262297927, 11048.889511104786, 11869.406529673655, 11915.40422978865, 10412.947935260578, 10422.322549034288, 10540.156787456832, 10832.891671083504, 10908.963648453384, 4926.5073492650445, 8793.824123517366, 10156.542955567165, 10194.286399951932, 10408.375497470177, 10516.0, 10662.0, 10665.9466702666, 10709.303895246783, 10834.783304334027, 7655.6937722490475, 7692.499987501018, 7693.730719425017, 7750.457467977413, 7814.804629884298, 8830.735077947671, 10148.188144948534, 10311.484425778832, 10523.947380263357, 10613.257072005194], "unit": "score", "name": "jquery.html", "value": 8086.557181701972}, {"lowerIsBetter": false, "replicates": [1308.136629824316, 1448.855114488551, 1457.2422340382998, 1612.3389410341754, 1804.7563578916843, 6645.368689974451, 7171.5338502997265, 7297.197308296097, 7344.339009489145, 7365.926340736591, 7389.5935723535185, 7535.585542795144, 7540.39676825854, 7545.132309784376, 7547.3584745296575, 1942.300771722179, 1987.1157334985937, 1988.9502762430911, 2246.618074927258, 2279.122537822942, 2249.6962910007187, 2295.5753185660624, 2299.0, 2303.0672577606097, 2309.1571576374586, 2197.7362716474045, 2203.3830527452337, 2218.8446808723397, 2221.855579387343, 2273.954520909581, 2235.9552808943813, 2244.7306323241314, 2246.067881829039, 2246.84272100953, 2247.1797793805226, 2137.1237792505, 2200.768919263486, 2200.8899555022185, 2206.9889650551804, 2208.2712704807377, 7662.9233707663325, 7688.115866675348, 7689.038870141232, 7704.0, 7708.0750309962605, 4594.1730488512385, 4708.364370809931, 4710.481846996828, 4722.1028004679, 4730.834420795256, 3162.8734850605947, 3163.31988622445, 3191.4095892260007, 3222.629397619257, 3258.5763850699495, 999.3054826895311, 1009.9899001009969, 1016.9440680762555, 1044.4725413666126, 1078.4769386847372, 10502.527386267637, 10534.894651053468, 10536.420496872668, 10546.630867919586, 10550.788984220273, 4329.588689074596, 4373.190959672471, 4463.509014008457, 4489.663275254369, 4490.60791154743, 8973.28213742899, 8999.955000225087, 9033.819323613623, 9039.63841446348, 9048.683296084606, 4829.203181475017, 4831.541003604652, 4834.057358814997, 4835.178019736653, 4837.032593481318, 3726.292004519187, 4087.652549533323, 4253.617174454314, 4360.106178233455, 4362.454693163355, 3603.6936860367164, 3639.6724294813594, 3647.66860096063, 3669.321175582526, 3708.8145592720257, 1225.4914210602678, 1240.0761432732672, 1241.6523373455448, 1244.8319476870506, 1255.9560415385417, 942.241495596038, 960.0, 963.6723514005272, 1007.561710655867, 1202.4288462980014, 7104.25405332443, 7160.10498687664, 7200.639968001579, 7209.855802883913, 7212.134543854771, 449.13765570105477, 450.5359479735877, 453.605363333895, 456.2631350369196, 456.56170076726715, 5392.838214853561, 5421.566274698014, 5453.836384908459, 5462.426445223274, 5486.286782718301, 9282.396644218239, 9634.566444510014, 9644.0, 9654.903450965401, 9655.08276713711, 9279.953600231956, 9381.54586039165, 9404.482753448488, 9433.952830235805, 9439.76400589977, 7131.536450130829, 7182.820429489305, 7222.96388518054, 7288.6720097595735, 7289.08886389212, 6740.595564266159, 6742.898856517254, 6781.287964763629, 6799.490038247052, 6799.660016999229, 8249.79375515617, 8346.833063338578, 8414.242718155396, 8466.703665371682, 8482.533460659723, 8485.109063548485, 8570.48577085377, 8579.099194584729, 8583.785405364915, 8698.043215246444, 5682.346530149086, 6027.78902738402, 6180.721867515883, 6773.559718618274, 6849.24658287598, 7129.7861064168155, 7134.714611415485, 7140.357367836712, 7163.212046674966, 7178.748743793943, 6393.392627700361, 6539.6403197824575, 6545.181852268466, 6648.5678430901835, 6709.329067093252, 6301.495880329654, 6452.451541619015, 6461.127747753993, 6580.670966451754, 6636.601803891782, 6795.660216989032, 6809.489288303496, 6834.829129271808, 6851.520393572601, 6852.520323577502, 6184.536159788124, 6277.560570760185, 6285.371462853678, 6319.46284565817, 6323.0, 6257.937420625917, 6339.112524246517, 6339.651319177489, 6359.427651511386, 6384.042393640991], "unit": "score", "name": "mootools.html", "value": 4289.490368694769}, {"lowerIsBetter": false, "replicates": [318.087090051552, 322.1736246527658, 324.1830586920961, 324.482450491466, 326.58360590247446, 5332.120200166973, 5392.379876314225, 5422.024035673582, 5443.265159203506, 5451.454854514546, 5319.946800531993, 5336.43967383424, 5354.625176237665, 5360.115580929152, 5369.677819330833, 3949.4668219790246, 4022.4971878515184, 4105.322621767405, 4157.937630935531, 4173.499180098393, 4129.339305711087, 4130.669546436278, 4158.0, 4164.583541645827, 4171.812268447927, 4116.176764647068, 4125.2780763366445, 4127.484064491939, 4137.751734895901, 4141.6065473779945, 3964.3062464068817, 4056.9391459128137, 4109.198706252252, 4114.5679703630985, 4132.896677583084, 3634.7092232621326, 3638.05410593245, 3639.1811842335264, 3644.489771432002, 3648.890533284006, 5038.445770965191, 5053.747312634354, 5063.569596584258, 5133.0, 5138.7173705446185, 4836.298736683197, 4837.612990960714, 4842.951570484285, 4851.51484851512, 4853.830115945961, 5634.323881134249, 5636.323641163046, 5643.830685079454, 5653.9151912721345, 5661.2357331760095, 3964.2161027537436, 4059.756414615103, 4073.4704488416614, 4080.3471444569022, 4082.795860206978, 5858.619189752652, 5913.822585322448, 5925.051991681354, 5928.081147422156, 5930.525557955353, 4140.130572579732, 4155.1897380010605, 4155.8961025974595, 4160.334346504545, 4165.66674666026, 4202.579742025773, 4232.619064284229, 4233.491980962242, 4236.618704316565, 4246.532881383046, 4803.279508073747, 4807.78364973577, 4808.783604737795, 4810.927836082462, 4814.229723244264, 5662.518685911661, 5662.971685141631, 5663.377028526858, 5663.461971112738, 5666.716664166775, 1439.7048605035943, 1468.860458256464, 1493.4250313629113, 1493.6713922936935, 1496.2518740629685, 942.7690215897012, 972.8054389122062, 988.2143695761887, 1014.7412409835592, 1017.9287449878437, 4784.043191361672, 4846.200376937766, 4858.611311095104, 4950.455449900508, 4968.850934471971, 5876.559258055663, 5907.881842363215, 5915.3788852170765, 5917.142014407887, 5919.55603329752, 4986.077575648516, 4986.127427700138, 4997.225430058346, 4998.2002879539095, 5003.649744517848, 3108.4404807134933, 3139.262273365757, 3154.1168472827644, 3155.4477966356253, 3163.7469002480207, 5575.107982722745, 5581.469760372758, 5592.748326325243, 5592.972035139798, 5594.720263986866, 5870.853228669317, 6036.456718895321, 6049.153118563405, 6060.090986351995, 6060.575759696779, 5544.974179776754, 5583.944160558423, 5588.77644894216, 5594.104943208986, 5595.776168953278, 5892.852678683067, 5895.263092113486, 5903.291605007426, 5907.113932910098, 5918.7928422505, 5785.537157027344, 5787.6816775076095, 5794.82615521535, 5796.0, 5799.5070419014855, 5342.465753424626, 5581.944180558143, 5582.051051321204, 5592.245046918614, 5601.355844077821, 3969.0672691916798, 4028.597140285948, 4046.8785936421955, 4052.149048699688, 4053.695972801993, 5873.765049397976, 5885.47030767233, 5893.263342082239, 5952.464278214981, 5957.434043765836, 5684.175794509855, 5686.488216060575, 5686.601937864475, 5696.088625819849, 5697.3448053474385, 5666.716664166693, 5676.858078548069, 5682.687452190004, 5691.373948865538, 5692.089265717465, 5347.5721942243745, 5537.1140617501005, 5557.02752018387, 5558.861028474159, 5561.721913904208, 5700.600957933071, 5718.914216286842, 5725.942740572541, 5733.369329373849, 5741.311042674905, 5549.139883318092, 5579.637323573955, 5588.804391846266, 5599.748011339581, 5600.579956503197], "unit": "score", "name": "prototype.html", "value": 4269.7918626563405}, {"lowerIsBetter": false, "replicates": [685.3797313431345, 720.8053825467125, 772.4438404348874, 798.4730078148419, 798.9800254993628, 12538.623841284765, 12607.747845043094, 12713.36433178342, 12719.10966232363, 12725.936370318159, 11997.22018068825, 12010.099242556822, 12048.39758012098, 12066.758664826699, 12078.516859325617, 644.043595261037, 786.4573444323427, 812.5409143833745, 813.0649752784316, 813.1908750792969, 809.6154326694802, 816.5304949653943, 816.6896579299857, 817.2032268538157, 818.3167055508658, 686.8969654551807, 858.3862538285125, 859.0507489224411, 859.70769938221, 859.7893516088567, 690.3683129936103, 691.2361840166594, 833.829065041665, 850.1923172985627, 852.5779739029158, 625.6089943785134, 626.7148447456397, 628.0798630007016, 628.5694299404922, 629.1600713048086, 12236.082293827909, 12280.570180043656, 12308.569200077955, 12340.321282329469, 12370.13409061357, 11924.344161071138, 12347.629571112791, 12664.209148759726, 12726.300053497054, 12789.232646041268, 9806.90193098074, 9901.455419951899, 10018.0, 10027.448490333029, 10149.391036537758, 3384.6784555467193, 3415.573053368329, 3427.880024199166, 3522.189896323834, 3540.6459354064646, 42402.0, 42432.36351454731, 42587.148257034685, 42762.35856462156, 43348.0, 9747.0, 9959.651412200537, 9988.750281243027, 9998.450085245382, 10042.096211341015, 17775.911120444314, 17826.37607683725, 17841.28634854617, 18035.909820451077, 18072.819271807377, 6750.459963202932, 6769.255381907986, 6779.186497620317, 6781.186257649114, 7140.393066589294, 3913.941290880639, 3931.331673615492, 3995.420664003703, 4051.4530538376944, 4056.006278461796, 2907.0552070577146, 2947.2337192330147, 2952.734253917115, 2955.054382597591, 2989.9402011960074, 535.028922505651, 538.9571179767163, 542.7747484793846, 546.3798588601886, 547.8931608336336, 518.6602775182262, 580.9738561764731, 596.4989408896548, 616.9383061693794, 619.3434958943534, 8243.134470880592, 8364.330853531703, 8543.316534677211, 8555.443896146731, 8583.656653733906, 491.69514900761754, 615.0374663651371, 615.3784677475782, 622.3931666625095, 643.2088531106765, 3584.8566057357934, 3626.546681664792, 3893.377059670439, 3979.9403008954887, 4037.8788636340955, 45910.0, 46735.76632116818, 55233.171502427496, 55879.44120558743, 56031.71984140053, 42362.788186059486, 43343.13313733708, 43639.0, 43759.562404376185, 44045.0, 40070.39894401586, 40335.59664403318, 40448.19103617911, 40450.79774601167, 40516.594834051284, 8650.783730406538, 8661.437006594551, 8759.343049271203, 8815.691450799448, 8878.955605221932, 30500.237494062825, 31014.844925775225, 31860.0, 32099.839500802347, 33042.0, 36332.0, 38700.612993870825, 39081.80459097686, 39165.608343916196, 39228.803855980535, 10200.540975655966, 10205.336653117523, 10366.222533309881, 10680.8931910683, 10902.400367979837, 12166.330851802883, 12172.39138043112, 12219.327936963553, 12334.0, 12938.935305323414, 8778.466258890976, 10689.251752377259, 11458.713532161762, 11842.763144736884, 11871.643850684493, 10414.47927603632, 10516.684499464722, 10624.946875265574, 10647.787044258917, 10652.680419587425, 10812.405317707287, 10976.121910247002, 11053.115750740082, 11058.170637202082, 11139.610113645984, 9308.95345523268, 9396.15434610861, 9638.9036109638, 9812.901870981199, 10115.898841011496, 9554.474503902353, 9569.952150239204, 9619.086186812241, 9633.759156021155, 9697.22422206236], "unit": "score", "name": "yui.html", "value": 5974.604794157905}], "name": "dromaeo_css", "value": 6374.604925286937}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 111.0, 113.0, 112.0, 103.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 159.0, 197.0, 133.0, 166.0, 157.0, 134.0, 175.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 153.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 161.0, 161.0, 162.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 124.0, 108.0, 74.0, 77.0, 75.0, 133.0, 101.0, 77.0], "unit": "score", "name": "audio-fft", "value": 91.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 133.0, 93.0, 93.0, 93.0, 146.0, 93.0, 93.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 63.0, 63.0, 64.0, 72.0, 61.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 64.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 82.0, 84.0, 90.0, 85.0, 81.0, 81.0, 82.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [118.0, 118.0, 118.0, 122.0, 114.0, 118.0, 123.0, 126.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [144.0, 142.0, 142.0, 145.0, 148.0, 136.0, 145.0, 137.0, 138.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.1}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 67.0, 69.0, 70.0, 72.0, 68.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1525.1999999999996}]} 10:43:03 INFO - Return code: 0 10:43:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:43:03 ERROR - # TBPL SUCCESS # 10:43:03 INFO - Running post-action listener: _resource_record_post_action 10:43:03 INFO - Running post-run listener: _resource_record_post_run 10:43:04 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519311360; Read time: 8; Write time: 500388 10:43:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233164800; Read time: 0; Write time: 344392 10:43:04 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286146560; Read time: 8; Write time: 155996 10:43:04 INFO - Running post-run listener: _upload_blobber_files 10:43:04 INFO - Blob upload gear active. 10:43:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:43:04 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 10:43:04 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'] 10:43:04 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 10:43:05 INFO - (blobuploader) - INFO - Open directory for files ... 10:43:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:43:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:43:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:06 INFO - (blobuploader) - INFO - Done attempting. 10:43:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:43:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:43:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:43:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:43:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:43:07 INFO - (blobuploader) - INFO - Done attempting. 10:43:07 INFO - (blobuploader) - INFO - Iteration through files over. 10:43:07 INFO - Return code: 0 10:43:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:43:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:43:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ba1da7a4503d992ddc6b79a5dc76c16c2cd52e78e26790f01d3a0454bbd1ef02b29b320bc05db48d1c0e4c5544b872a347fc18f11d0aa5b706931c46503edb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d65018e2a000c8f48f0e008a4d144be8736a56b9f1962c98b0910c25d5e174c50e5801af960a40774d402a1907770d7bfe16e93da0888b7e66b83aa618f4d48"} 10:43:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:43:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:43:07 INFO - Contents: 10:43:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ba1da7a4503d992ddc6b79a5dc76c16c2cd52e78e26790f01d3a0454bbd1ef02b29b320bc05db48d1c0e4c5544b872a347fc18f11d0aa5b706931c46503edb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d65018e2a000c8f48f0e008a4d144be8736a56b9f1962c98b0910c25d5e174c50e5801af960a40774d402a1907770d7bfe16e93da0888b7e66b83aa618f4d48"} 10:43:07 INFO - Running post-run listener: copy_logs_to_upload_dir 10:43:07 INFO - Copying logs to upload dir... 10:43:07 INFO - mkdir: /builds/slave/test/build/upload/logs 10:43:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.621543 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-03-25 10:43:07.155734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 10:43:07.159689) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 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/8ba1da7a4503d992ddc6b79a5dc76c16c2cd52e78e26790f01d3a0454bbd1ef02b29b320bc05db48d1c0e4c5544b872a347fc18f11d0aa5b706931c46503edb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d65018e2a000c8f48f0e008a4d144be8736a56b9f1962c98b0910c25d5e174c50e5801af960a40774d402a1907770d7bfe16e93da0888b7e66b83aa618f4d48"} build_url:https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/VReyG25tSXCQfYf-IfzgeA/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/8ba1da7a4503d992ddc6b79a5dc76c16c2cd52e78e26790f01d3a0454bbd1ef02b29b320bc05db48d1c0e4c5544b872a347fc18f11d0aa5b706931c46503edb6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d65018e2a000c8f48f0e008a4d144be8736a56b9f1962c98b0910c25d5e174c50e5801af960a40774d402a1907770d7bfe16e93da0888b7e66b83aa618f4d48"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 10:43:07.196862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:43:07.197311) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1458926318.21424-857731807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 10:43:07.293306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 10:43:07.293655) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 10:43:07.293982) ========= ========= Total master_lag: 0.30 =========