builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1456395458.26 results: success (0) buildid: 20160225013854 builduid: 73fb70ebc5a1483f8bbc38208b2792ad revision: 06d90f15b4f462182c158b7e3862e97ce7a0bc1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.255990) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.256416) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.256716) ========= 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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006749 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.277678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.277947) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.292524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.292870) ========= 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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004826 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.341545) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.341818) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.342164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.342435) ========= 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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-25 02:17:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2016-02-25 02:17:39 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.534984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.535306) ========= 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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017288 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:38.584570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 02:17:38.584928) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 06d90f15b4f462182c158b7e3862e97ce7a0bc1f --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 06d90f15b4f462182c158b7e3862e97ce7a0bc1f --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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-25 02:17:39,931 truncating revision to first 12 chars 2016-02-25 02:17:39,931 Setting DEBUG logging. 2016-02-25 02:17:39,931 attempt 1/10 2016-02-25 02:17:39,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/06d90f15b4f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 02:17:40,636 unpacking tar archive at: fx-team-06d90f15b4f4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.993816 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 02:17:39.594405) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:39.595225) ========= echo 06d90f15b4f462182c158b7e3862e97ce7a0bc1f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'06d90f15b4f462182c158b7e3862e97ce7a0bc1f'] 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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06d90f15b4f462182c158b7e3862e97ce7a0bc1f program finished with exit code 0 elapsedTime=0.004712 script_repo_revision: '06d90f15b4f462182c158b7e3862e97ce7a0bc1f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:39.650509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:39.651206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 02:17:39.661655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-25 02:17:39.661919) ========= /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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:17:41 INFO - MultiFileLogger online at 20160225 02:17:41 in /builds/slave/test 02:17:41 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 02:17:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:17:41 INFO - {'append_to_log': False, 02:17:41 INFO - 'base_work_dir': '/builds/slave/test', 02:17:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:17:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:17:41 INFO - 'branch': 'Fx-Team-Non-PGO', 02:17:41 INFO - 'buildbot_json_path': 'buildprops.json', 02:17:41 INFO - 'config_files': ('talos/linux_config.py',), 02:17:41 INFO - 'default_actions': ('clobber', 02:17:41 INFO - 'read-buildbot-config', 02:17:41 INFO - 'download-and-extract', 02:17:41 INFO - 'populate-webroot', 02:17:41 INFO - 'create-virtualenv', 02:17:41 INFO - 'install', 02:17:41 INFO - 'run-tests'), 02:17:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:17:41 INFO - 'download_minidump_stackwalk': True, 02:17:41 INFO - 'download_symbols': 'ondemand', 02:17:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:17:41 INFO - 'tooltool.py': '/tools/tooltool.py', 02:17:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:17:41 INFO - '/tools/misc-python/virtualenv.py')}, 02:17:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:17:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:17:41 INFO - 'installer_path': 'installer.exe', 02:17:41 INFO - 'log_level': 'info', 02:17:41 INFO - 'log_name': 'talos', 02:17:41 INFO - 'log_to_console': True, 02:17:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:17:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:17:41 INFO - 'opt_config_files': (), 02:17:41 INFO - 'pip_index': False, 02:17:41 INFO - 'sps_profile': False, 02:17:41 INFO - 'sps_profile_interval': 0, 02:17:41 INFO - 'suite': 'dromaeojs', 02:17:41 INFO - 'system_bits': '32', 02:17:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:17:41 INFO - 'title': 'talos-linux64-ix-069', 02:17:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:17:41 INFO - 'use_talos_json': True, 02:17:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:17:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:17:41 INFO - 'work_dir': 'build'} 02:17:41 INFO - ##### 02:17:41 INFO - ##### Running clobber step. 02:17:41 INFO - ##### 02:17:41 INFO - Running pre-action listener: _resource_record_pre_action 02:17:41 INFO - Running main action method: clobber 02:17:41 INFO - rmtree: /builds/slave/test/build 02:17:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:17:41 INFO - Running post-action listener: _resource_record_post_action 02:17:41 INFO - ##### 02:17:41 INFO - ##### Running read-buildbot-config step. 02:17:41 INFO - ##### 02:17:41 INFO - Running pre-action listener: _resource_record_pre_action 02:17:41 INFO - Running main action method: read_buildbot_config 02:17:41 INFO - Using buildbot properties: 02:17:41 INFO - { 02:17:41 INFO - "project": "", 02:17:41 INFO - "product": "firefox", 02:17:41 INFO - "script_repo_revision": "production", 02:17:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:17:41 INFO - "repository": "", 02:17:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:17:41 INFO - "buildid": "20160225013854", 02:17:41 INFO - "pgo_build": "False", 02:17:41 INFO - "basedir": "/builds/slave/test", 02:17:41 INFO - "buildnumber": 2550, 02:17:41 INFO - "slavename": "talos-linux64-ix-069", 02:17:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:17:41 INFO - "platform": "ubuntu64_hw", 02:17:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:17:41 INFO - "branch": "fx-team", 02:17:41 INFO - "repo_path": "integration/fx-team", 02:17:41 INFO - "revision": "06d90f15b4f462182c158b7e3862e97ce7a0bc1f", 02:17:41 INFO - "stage_platform": "linux64", 02:17:41 INFO - "builduid": "73fb70ebc5a1483f8bbc38208b2792ad", 02:17:41 INFO - "slavebuilddir": "test" 02:17:41 INFO - } 02:17:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 02:17:41 INFO - Running post-action listener: _resource_record_post_action 02:17:41 INFO - ##### 02:17:41 INFO - ##### Running download-and-extract step. 02:17:41 INFO - ##### 02:17:41 INFO - Running pre-action listener: _resource_record_pre_action 02:17:41 INFO - Running main action method: download_and_extract 02:17:41 INFO - mkdir: /builds/slave/test/build/tests 02:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:41 INFO - https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/test_packages.json 02:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/test_packages.json 02:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:17:42 INFO - Downloaded 1448 bytes. 02:17:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:17:42 INFO - Using the following test package requirements: 02:17:42 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:42 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:17:42 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:17:42 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:42 INFO - u'jsshell-linux-x86_64.zip'], 02:17:42 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:17:42 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:42 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:17:42 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:17:42 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:17:42 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:17:42 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:17:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:17:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:42 INFO - https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:17:43 INFO - Downloaded 22054750 bytes. 02:17:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:17:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:17:44 INFO - Return code: 0 02:17:44 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:44 INFO - https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:17:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:17:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:17:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:17:45 INFO - Downloaded 22054750 bytes. 02:17:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:17:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:17:46 INFO - Return code: 0 02:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:46 INFO - https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:17:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:17:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:17:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:17:47 INFO - Downloaded 10707015 bytes. 02:17:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:17:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:17:48 INFO - Return code: 0 02:17: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')]} 02:17:48 INFO - https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:17:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:17:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:17:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:17:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:17:49 INFO - Downloaded 54834928 bytes. 02:17:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:17:49 INFO - mkdir: /builds/slave/test/properties 02:17:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:17:49 INFO - Writing to file /builds/slave/test/properties/build_url 02:17:49 INFO - Contents: 02:17:49 INFO - build_url:https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:17:50 INFO - Running post-action listener: _resource_record_post_action 02:17:50 INFO - Running post-action listener: set_extra_try_arguments 02:17:50 INFO - ##### 02:17:50 INFO - ##### Running populate-webroot step. 02:17:50 INFO - ##### 02:17:50 INFO - Running pre-action listener: _resource_record_pre_action 02:17:50 INFO - Running main action method: populate_webroot 02:17:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:17:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:17:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:17:50 INFO - '--tppagecycles', 02:17:50 INFO - '7'], 02:17:50 INFO - 'tests': ['tsvgm']}}, 02:17:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:17:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:17:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:17:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:17:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:50 INFO - 'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:17:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:50 INFO - 'tests': ['damp', 'tps']}, 02:17:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:50 INFO - 'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['damp', 'tps']}, 02:17:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:17:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:17:50 INFO - 'other': {'tests': ['a11yr', 02:17:50 INFO - 'ts_paint', 02:17:50 INFO - 'tpaint', 02:17:50 INFO - 'sessionrestore', 02:17:50 INFO - 'sessionrestore_no_auto_restore']}, 02:17:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['a11yr', 02:17:50 INFO - 'ts_paint', 02:17:50 INFO - 'tpaint', 02:17:50 INFO - 'sessionrestore', 02:17:50 INFO - 'sessionrestore_no_auto_restore']}, 02:17:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['a11yr', 02:17:50 INFO - 'ts_paint', 02:17:50 INFO - 'tpaint', 02:17:50 INFO - 'sessionrestore', 02:17:50 INFO - 'sessionrestore_no_auto_restore']}, 02:17:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['a11yr', 02:17:50 INFO - 'ts_paint', 02:17:50 INFO - 'tpaint', 02:17:50 INFO - 'sessionrestore', 02:17:50 INFO - 'sessionrestore_no_auto_restore']}, 02:17:50 INFO - 'other_l64': {'tests': ['a11yr', 02:17:50 INFO - 'ts_paint', 02:17:50 INFO - 'tpaint', 02:17:50 INFO - 'sessionrestore', 02:17:50 INFO - 'sessionrestore_no_auto_restore']}, 02:17:50 INFO - 'other_nol64': {'tests': ['a11yr', 02:17:50 INFO - 'ts_paint', 02:17:50 INFO - 'tpaint', 02:17:50 INFO - 'sessionrestore', 02:17:50 INFO - 'sessionrestore_no_auto_restore']}, 02:17:50 INFO - 'svgr': {'tests': ['tsvgx', 02:17:50 INFO - 'tsvgr_opacity', 02:17:50 INFO - 'tart', 02:17:50 INFO - 'tscrollx', 02:17:50 INFO - 'cart']}, 02:17:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['tsvgx', 02:17:50 INFO - 'tsvgr_opacity', 02:17:50 INFO - 'tart', 02:17:50 INFO - 'tscrollx', 02:17:50 INFO - 'cart']}, 02:17:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:50 INFO - 'tests': ['tp5o']}, 02:17:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:50 INFO - 'talos_options': ['--e10s'], 02:17:50 INFO - 'tests': ['tp5o']}, 02:17:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:50 INFO - 'talos_options': ['--xperf_path', 02:17:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:50 INFO - 'tests': ['tp5n']}, 02:17:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:17:50 INFO - 'talos_options': ['--e10s', 02:17:50 INFO - '--xperf_path', 02:17:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:17:50 INFO - 'tests': ['tp5n']}}, 02:17:50 INFO - 'talos.zip': {'path': '', 02:17:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:17:50 INFO - Running post-action listener: _resource_record_post_action 02:17:50 INFO - ##### 02:17:50 INFO - ##### Running create-virtualenv step. 02:17:50 INFO - ##### 02:17:50 INFO - Running pre-action listener: _resource_record_pre_action 02:17:50 INFO - Running main action method: create_virtualenv 02:17:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:17:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:17:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:17:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:17:50 INFO - Using real prefix '/usr' 02:17:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:17:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:17:52 INFO - Installing pip.................done. 02:17:52 INFO - Return code: 0 02:17:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:17:52 INFO - Using env: {'DISPLAY': ':0', 02:17:52 INFO - 'HOME': '/home/cltbld', 02:17:52 INFO - 'LANG': 'en_US.UTF-8', 02:17:52 INFO - 'LANGUAGE': 'en_US:en', 02:17:52 INFO - 'LOGNAME': 'cltbld', 02:17:52 INFO - 'MAIL': '/var/mail/cltbld', 02:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:52 INFO - 'MOZ_NO_REMOTE': '1', 02:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:52 INFO - 'NO_EM_RESTART': '1', 02:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:52 INFO - 'PWD': '/builds/slave/test', 02:17:52 INFO - 'SHELL': '/bin/bash', 02:17:52 INFO - 'SHLVL': '1', 02:17:52 INFO - 'TERM': 'linux', 02:17:52 INFO - 'TMOUT': '86400', 02:17:52 INFO - 'USER': 'cltbld', 02:17:52 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:52 INFO - '_': '/tools/buildbot/bin/python'} 02:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:52 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 02:17:52 INFO - Cleaning up... 02:17:52 INFO - Return code: 0 02:17:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:17:52 INFO - Using env: {'DISPLAY': ':0', 02:17:52 INFO - 'HOME': '/home/cltbld', 02:17:52 INFO - 'LANG': 'en_US.UTF-8', 02:17:52 INFO - 'LANGUAGE': 'en_US:en', 02:17:52 INFO - 'LOGNAME': 'cltbld', 02:17:52 INFO - 'MAIL': '/var/mail/cltbld', 02:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:52 INFO - 'MOZ_NO_REMOTE': '1', 02:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:52 INFO - 'NO_EM_RESTART': '1', 02:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:52 INFO - 'PWD': '/builds/slave/test', 02:17:52 INFO - 'SHELL': '/bin/bash', 02:17:52 INFO - 'SHLVL': '1', 02:17:52 INFO - 'TERM': 'linux', 02:17:52 INFO - 'TMOUT': '86400', 02:17:52 INFO - 'USER': 'cltbld', 02:17:52 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:52 INFO - '_': '/tools/buildbot/bin/python'} 02:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:53 INFO - Downloading/unpacking psutil>=0.7.1 02:17: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 02:17: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 02:17: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 02:17: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 02:17: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 02:17: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 02:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:17:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:55 INFO - Installing collected packages: psutil 02:17:55 INFO - Running setup.py install for psutil 02:17:55 INFO - building 'psutil._psutil_linux' extension 02:17:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:17:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:17:55 INFO - building 'psutil._psutil_posix' extension 02:17:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:17:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:17:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:17:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:17:55 INFO - Successfully installed psutil 02:17:55 INFO - Cleaning up... 02:17:55 INFO - Return code: 0 02:17:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:17:55 INFO - Using env: {'DISPLAY': ':0', 02:17:55 INFO - 'HOME': '/home/cltbld', 02:17:55 INFO - 'LANG': 'en_US.UTF-8', 02:17:55 INFO - 'LANGUAGE': 'en_US:en', 02:17:55 INFO - 'LOGNAME': 'cltbld', 02:17:55 INFO - 'MAIL': '/var/mail/cltbld', 02:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:55 INFO - 'MOZ_NO_REMOTE': '1', 02:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:55 INFO - 'NO_EM_RESTART': '1', 02:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:55 INFO - 'PWD': '/builds/slave/test', 02:17:55 INFO - 'SHELL': '/bin/bash', 02:17:55 INFO - 'SHLVL': '1', 02:17:55 INFO - 'TERM': 'linux', 02:17:55 INFO - 'TMOUT': '86400', 02:17:55 INFO - 'USER': 'cltbld', 02:17:55 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:55 INFO - '_': '/tools/buildbot/bin/python'} 02:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:17:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:17:57 INFO - Installing collected packages: mozsystemmonitor 02:17:57 INFO - Running setup.py install for mozsystemmonitor 02:17:57 INFO - Successfully installed mozsystemmonitor 02:17:57 INFO - Cleaning up... 02:17:57 INFO - Return code: 0 02:17:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:17: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')]} 02:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17: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')]} 02:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:17:57 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 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:17:57 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 02:17:57 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 02:17:57 INFO - Using env: {'DISPLAY': ':0', 02:17:57 INFO - 'HOME': '/home/cltbld', 02:17:57 INFO - 'LANG': 'en_US.UTF-8', 02:17:57 INFO - 'LANGUAGE': 'en_US:en', 02:17:57 INFO - 'LOGNAME': 'cltbld', 02:17:57 INFO - 'MAIL': '/var/mail/cltbld', 02:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:57 INFO - 'MOZ_NO_REMOTE': '1', 02:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:57 INFO - 'NO_EM_RESTART': '1', 02:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:57 INFO - 'PWD': '/builds/slave/test', 02:17:57 INFO - 'SHELL': '/bin/bash', 02:17:57 INFO - 'SHLVL': '1', 02:17:57 INFO - 'TERM': 'linux', 02:17:57 INFO - 'TMOUT': '86400', 02:17:57 INFO - 'USER': 'cltbld', 02:17:57 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:57 INFO - '_': '/tools/buildbot/bin/python'} 02:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:17:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:17: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 02:17: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 02:17: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 02:17: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 02:17: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 02:17: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 02:17:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:18:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:18:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:00 INFO - Downloading docopt-0.6.1.tar.gz 02:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:18:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:18:00 INFO - Running setup.py install for blobuploader 02:18:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:18:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:18:00 INFO - Running setup.py install for requests 02:18:01 INFO - Running setup.py install for docopt 02:18:01 INFO - Successfully installed blobuploader requests docopt 02:18:01 INFO - Cleaning up... 02:18:01 INFO - Return code: 0 02:18:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:18:01 INFO - Using env: {'DISPLAY': ':0', 02:18:01 INFO - 'HOME': '/home/cltbld', 02:18:01 INFO - 'LANG': 'en_US.UTF-8', 02:18:01 INFO - 'LANGUAGE': 'en_US:en', 02:18:01 INFO - 'LOGNAME': 'cltbld', 02:18:01 INFO - 'MAIL': '/var/mail/cltbld', 02:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:01 INFO - 'MOZ_NO_REMOTE': '1', 02:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:01 INFO - 'NO_EM_RESTART': '1', 02:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:01 INFO - 'PWD': '/builds/slave/test', 02:18:01 INFO - 'SHELL': '/bin/bash', 02:18:01 INFO - 'SHLVL': '1', 02:18:01 INFO - 'TERM': 'linux', 02:18:01 INFO - 'TMOUT': '86400', 02:18:01 INFO - 'USER': 'cltbld', 02:18:01 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:01 INFO - '_': '/tools/buildbot/bin/python'} 02:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:01 INFO - Running setup.py (path:/tmp/pip-CsS8FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:01 INFO - Running setup.py (path:/tmp/pip-FFP64i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:01 INFO - Running setup.py (path:/tmp/pip-FKweZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:01 INFO - Running setup.py (path:/tmp/pip-jO6UrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:01 INFO - Running setup.py (path:/tmp/pip-AdQKD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:01 INFO - Running setup.py (path:/tmp/pip-Mbh8XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:01 INFO - Running setup.py (path:/tmp/pip-Hdtlyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:02 INFO - Running setup.py (path:/tmp/pip-JccHlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:02 INFO - Running setup.py (path:/tmp/pip-1t3KJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:02 INFO - Running setup.py (path:/tmp/pip-VpK_WC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:02 INFO - Running setup.py (path:/tmp/pip-QxsyQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:02 INFO - Running setup.py (path:/tmp/pip-psdDdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:02 INFO - Running setup.py (path:/tmp/pip-UQaqT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:02 INFO - Running setup.py (path:/tmp/pip-KCiZ_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:02 INFO - Running setup.py (path:/tmp/pip-tlFSkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:02 INFO - Running setup.py (path:/tmp/pip-29E8G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:02 INFO - Running setup.py (path:/tmp/pip-wdWTSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:18:02 INFO - Running setup.py install for manifestparser 02:18:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:18:02 INFO - Running setup.py install for mozcrash 02:18:02 INFO - Running setup.py install for mozdebug 02:18:03 INFO - Running setup.py install for mozdevice 02:18:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozfile 02:18:03 INFO - Running setup.py install for mozhttpd 02:18:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozinfo 02:18:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozInstall 02:18:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozleak 02:18:03 INFO - Running setup.py install for mozlog 02:18:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for moznetwork 02:18:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:18:03 INFO - Running setup.py install for mozprocess 02:18:04 INFO - Running setup.py install for mozprofile 02:18:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:18:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:18:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:18:04 INFO - Running setup.py install for mozrunner 02:18:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:18:04 INFO - Running setup.py install for mozscreenshot 02:18:04 INFO - Running setup.py install for moztest 02:18:04 INFO - Running setup.py install for mozversion 02:18:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:18:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:18:04 INFO - Cleaning up... 02:18:04 INFO - Return code: 0 02:18:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18: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')]} 02:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18: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')]} 02:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:18:04 INFO - Using env: {'DISPLAY': ':0', 02:18:04 INFO - 'HOME': '/home/cltbld', 02:18:04 INFO - 'LANG': 'en_US.UTF-8', 02:18:04 INFO - 'LANGUAGE': 'en_US:en', 02:18:04 INFO - 'LOGNAME': 'cltbld', 02:18:04 INFO - 'MAIL': '/var/mail/cltbld', 02:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:04 INFO - 'MOZ_NO_REMOTE': '1', 02:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:04 INFO - 'NO_EM_RESTART': '1', 02:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:04 INFO - 'PWD': '/builds/slave/test', 02:18:04 INFO - 'SHELL': '/bin/bash', 02:18:04 INFO - 'SHLVL': '1', 02:18:04 INFO - 'TERM': 'linux', 02:18:04 INFO - 'TMOUT': '86400', 02:18:04 INFO - 'USER': 'cltbld', 02:18:04 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:04 INFO - '_': '/tools/buildbot/bin/python'} 02:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:18:04 INFO - Running setup.py (path:/tmp/pip-DhZ0X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:18:04 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)) 02:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:18:04 INFO - Running setup.py (path:/tmp/pip-7LxvP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 02:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:18:04 INFO - Running setup.py (path:/tmp/pip-ArDpld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:18:05 INFO - Running setup.py (path:/tmp/pip-iqqRxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:18:05 INFO - Running setup.py (path:/tmp/pip-JLSv5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:18:05 INFO - Running setup.py (path:/tmp/pip-MsFcjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:18:05 INFO - Running setup.py (path:/tmp/pip-mz6GLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:18:05 INFO - Running setup.py (path:/tmp/pip-vFWr2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:18:05 INFO - Running setup.py (path:/tmp/pip-M7DVaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:18:05 INFO - Running setup.py (path:/tmp/pip-AZRub3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:18:05 INFO - Running setup.py (path:/tmp/pip-sswz9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:18:05 INFO - Running setup.py (path:/tmp/pip-vlfclh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:18:05 INFO - Running setup.py (path:/tmp/pip-HBPZ0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:18:05 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)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:18:05 INFO - Running setup.py (path:/tmp/pip-aJODDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:18:05 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)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:05 INFO - Running setup.py (path:/tmp/pip-HtZk90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:18:05 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)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:18:05 INFO - Running setup.py (path:/tmp/pip-U766gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:18:05 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)) 02:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:18:05 INFO - Running setup.py (path:/tmp/pip-AVdgu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:18:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18: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 02:18:07 INFO - Downloading blessings-1.6.tar.gz 02:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:18:07 INFO - Installing collected packages: blessings 02:18:07 INFO - Running setup.py install for blessings 02:18:08 INFO - Successfully installed blessings 02:18:08 INFO - Cleaning up... 02:18:08 INFO - Return code: 0 02:18:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:08 INFO - Reading from file tmpfile_stdout 02:18:08 INFO - Current package versions: 02:18:08 INFO - argparse == 1.2.1 02:18:08 INFO - blessings == 1.6 02:18:08 INFO - blobuploader == 1.2.4 02:18:08 INFO - docopt == 0.6.1 02:18:08 INFO - manifestparser == 1.1 02:18:08 INFO - mozInstall == 1.12 02:18:08 INFO - mozcrash == 0.16 02:18:08 INFO - mozdebug == 0.1 02:18:08 INFO - mozdevice == 0.48 02:18:08 INFO - mozfile == 1.2 02:18:08 INFO - mozhttpd == 0.7 02:18:08 INFO - mozinfo == 0.9 02:18:08 INFO - mozleak == 0.1 02:18:08 INFO - mozlog == 3.1 02:18:08 INFO - moznetwork == 0.27 02:18:08 INFO - mozprocess == 0.22 02:18:08 INFO - mozprofile == 0.28 02:18:08 INFO - mozrunner == 6.11 02:18:08 INFO - mozscreenshot == 0.1 02:18:08 INFO - mozsystemmonitor == 0.0 02:18:08 INFO - moztest == 0.7 02:18:08 INFO - mozversion == 1.4 02:18:08 INFO - psutil == 3.1.1 02:18:08 INFO - requests == 1.2.3 02:18:08 INFO - wsgiref == 0.1.2 02:18:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:18:08 INFO - Using env: {'DISPLAY': ':0', 02:18:08 INFO - 'HOME': '/home/cltbld', 02:18:08 INFO - 'LANG': 'en_US.UTF-8', 02:18:08 INFO - 'LANGUAGE': 'en_US:en', 02:18:08 INFO - 'LOGNAME': 'cltbld', 02:18:08 INFO - 'MAIL': '/var/mail/cltbld', 02:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:08 INFO - 'MOZ_NO_REMOTE': '1', 02:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:08 INFO - 'NO_EM_RESTART': '1', 02:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:08 INFO - 'PWD': '/builds/slave/test', 02:18:08 INFO - 'SHELL': '/bin/bash', 02:18:08 INFO - 'SHLVL': '1', 02:18:08 INFO - 'TERM': 'linux', 02:18:08 INFO - 'TMOUT': '86400', 02:18:08 INFO - 'USER': 'cltbld', 02:18:08 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:08 INFO - '_': '/tools/buildbot/bin/python'} 02:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:18:08 INFO - Cleaning up... 02:18:08 INFO - Return code: 0 02:18:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:18:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:18:08 INFO - Using env: {'DISPLAY': ':0', 02:18:08 INFO - 'HOME': '/home/cltbld', 02:18:08 INFO - 'LANG': 'en_US.UTF-8', 02:18:08 INFO - 'LANGUAGE': 'en_US:en', 02:18:08 INFO - 'LOGNAME': 'cltbld', 02:18:08 INFO - 'MAIL': '/var/mail/cltbld', 02:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:08 INFO - 'MOZ_NO_REMOTE': '1', 02:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:08 INFO - 'NO_EM_RESTART': '1', 02:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:08 INFO - 'PWD': '/builds/slave/test', 02:18:08 INFO - 'SHELL': '/bin/bash', 02:18:08 INFO - 'SHLVL': '1', 02:18:08 INFO - 'TERM': 'linux', 02:18:08 INFO - 'TMOUT': '86400', 02:18:08 INFO - 'USER': 'cltbld', 02:18:08 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:08 INFO - '_': '/tools/buildbot/bin/python'} 02:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:08 INFO - Downloading/unpacking jsonschema 02:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:18:10 INFO - Downloading/unpacking functools32 (from jsonschema) 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:18:10 INFO - warning: no files found matching '*.txt' 02:18:10 INFO - no previously-included directories found matching 'build' 02:18:10 INFO - no previously-included directories found matching 'dist' 02:18:10 INFO - no previously-included directories found matching '.git*' 02:18:10 INFO - Installing collected packages: jsonschema, functools32 02:18:10 INFO - Running setup.py install for functools32 02:18:10 INFO - warning: no files found matching '*.txt' 02:18:10 INFO - no previously-included directories found matching 'build' 02:18:10 INFO - no previously-included directories found matching 'dist' 02:18:10 INFO - no previously-included directories found matching '.git*' 02:18:10 INFO - Successfully installed jsonschema functools32 02:18:10 INFO - Cleaning up... 02:18:11 INFO - Return code: 0 02:18:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:18:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64d57f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, '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': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', '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 02:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:18:11 INFO - Using env: {'DISPLAY': ':0', 02:18:11 INFO - 'HOME': '/home/cltbld', 02:18:11 INFO - 'LANG': 'en_US.UTF-8', 02:18:11 INFO - 'LANGUAGE': 'en_US:en', 02:18:11 INFO - 'LOGNAME': 'cltbld', 02:18:11 INFO - 'MAIL': '/var/mail/cltbld', 02:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:11 INFO - 'MOZ_NO_REMOTE': '1', 02:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:11 INFO - 'NO_EM_RESTART': '1', 02:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:11 INFO - 'PWD': '/builds/slave/test', 02:18:11 INFO - 'SHELL': '/bin/bash', 02:18:11 INFO - 'SHLVL': '1', 02:18:11 INFO - 'TERM': 'linux', 02:18:11 INFO - 'TMOUT': '86400', 02:18:11 INFO - 'USER': 'cltbld', 02:18:11 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:11 INFO - '_': '/tools/buildbot/bin/python'} 02:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:18:11 INFO - Downloading/unpacking flake8 02:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:18:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:18:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:13 INFO - no previously-included directories found matching 'docs/_build' 02:18:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:18:13 INFO - Running setup.py install for pep8 02:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:18:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:18:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:18:13 INFO - no previously-included directories found matching 'docs/_build' 02:18:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:18:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:18:13 INFO - Cleaning up... 02:18:14 INFO - Return code: 0 02:18:14 INFO - Running post-action listener: _resource_record_post_action 02:18:14 INFO - Running post-action listener: _start_resource_monitoring 02:18:14 INFO - Starting resource monitoring. 02:18:14 INFO - ##### 02:18:14 INFO - ##### Running install step. 02:18:14 INFO - ##### 02:18:14 INFO - Running pre-action listener: _resource_record_pre_action 02:18:14 INFO - Running main action method: install 02:18:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:18:14 INFO - Reading from file tmpfile_stdout 02:18:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:18:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:18:14 INFO - Reading from file tmpfile_stdout 02:18:14 INFO - Output received: 02:18:14 INFO - Usage: mozinstall [options] installer 02:18:14 INFO - Options: 02:18:14 INFO - -h, --help show this help message and exit 02:18:14 INFO - -d DEST, --destination=DEST 02:18:14 INFO - Directory to install application into. [default: 02:18:14 INFO - "/builds/slave/test"] 02:18:14 INFO - --app=APP Application being installed. [default: firefox] 02:18:14 INFO - mkdir: /builds/slave/test/build/application 02:18:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:18:30 INFO - Reading from file tmpfile_stdout 02:18:30 INFO - Output received: 02:18:30 INFO - /builds/slave/test/build/application/firefox/firefox 02:18:30 INFO - Running post-action listener: _resource_record_post_action 02:18:30 INFO - ##### 02:18:30 INFO - ##### Running run-tests step. 02:18:30 INFO - ##### 02:18:30 INFO - Running pre-action listener: _resource_record_pre_action 02:18:30 INFO - Running main action method: run_tests 02:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:18:30 INFO - Python 2.7.3 02:18:30 INFO - Return code: 0 02:18:30 INFO - grabbing minidump binary from tooltool 02:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:18:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c9100>, '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 0x28ca000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ca490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:18:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:18:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:18:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:18:30 INFO - Return code: 0 02:18:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:18:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:18:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:18:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:18:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:18:31 INFO - Return code: 0 02:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 02:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 02:18:31 INFO - Using env: {'DISPLAY': ':0', 02:18:31 INFO - 'HOME': '/home/cltbld', 02:18:31 INFO - 'LANG': 'en_US.UTF-8', 02:18:31 INFO - 'LANGUAGE': 'en_US:en', 02:18:31 INFO - 'LOGNAME': 'cltbld', 02:18:31 INFO - 'MAIL': '/var/mail/cltbld', 02:18:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:18:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:18:31 INFO - 'MOZ_NO_REMOTE': '1', 02:18:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:18:31 INFO - 'NO_EM_RESTART': '1', 02:18:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:18:31 INFO - 'PWD': '/builds/slave/test', 02:18:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:18:31 INFO - 'SHELL': '/bin/bash', 02:18:31 INFO - 'SHLVL': '1', 02:18:31 INFO - 'TERM': 'linux', 02:18:31 INFO - 'TMOUT': '86400', 02:18:31 INFO - 'USER': 'cltbld', 02:18:31 INFO - 'XDG_SESSION_COOKIE': '1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050', 02:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:18:31 INFO - '_': '/tools/buildbot/bin/python'} 02:18:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 02:18:31 INFO - mozversion application_buildid: 20160225013854 02:18:31 INFO - mozversion application_changeset: 06d90f15b4f462182c158b7e3862e97ce7a0bc1f 02:18:31 INFO - mozversion application_display_name: Nightly 02:18:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:18:31 INFO - mozversion application_name: Firefox 02:18:31 INFO - mozversion application_remotingname: firefox 02:18:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:18:31 INFO - mozversion application_vendor: Mozilla 02:18:31 INFO - mozversion application_version: 47.0a1 02:18:31 INFO - mozversion platform_buildid: 20160225013854 02:18:31 INFO - mozversion platform_changeset: 06d90f15b4f462182c158b7e3862e97ce7a0bc1f 02:18:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:18:31 INFO - mozversion platform_version: 47.0a1 02:18:31 INFO - using testdate: 1456395511 02:18:31 INFO - actual date: 1456395511 02:18:31 INFO - starting webserver on 'localhost:33085' 02:18:31 INFO - SUITE-START | Running 2 tests 02:18:31 INFO - TEST-START | dromaeo_css 02:18:31 INFO - operating with platform_type : linux_ 02:18:31 INFO - Initialising browser for dromaeo_css test... 02:18:31 INFO - TEST-INFO | started process 8666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf2uE5h/profile http://localhost:33085/getInfo.html) 02:18:36 INFO - PROCESS | 8666 | __metrics Screen width/height:1600/1200 02:18:36 INFO - PROCESS | 8666 | colorDepth:24 02:18:36 INFO - PROCESS | 8666 | Browser inner width/height: 1024/697 02:18:36 INFO - PROCESS | 8666 | __metrics 02:18:37 INFO - PROCESS | 8666 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:18:38 INFO - TEST-INFO | 8666: exit 0 02:18:38 INFO - Browser initialized. 02:18:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:18:38 INFO - TEST-INFO | started process 8761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf2uE5h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:18:50 INFO - PROCESS | 8761 | RSS: Main: 147841024 02:18:50 INFO - PROCESS | 8761 | 02:19:41 INFO - PROCESS | 8761 | 1456395581926 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] 02:21:53 INFO - PROCESS | 8761 | Cycle 1(1): loaded http://localhost:33085/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33085/tests/dromaeo/cssquery-ext.html) 02:21:54 INFO - PROCESS | 8761 | RSS: Main: 271511552 02:21:54 INFO - PROCESS | 8761 | 02:24:56 INFO - PROCESS | 8761 | Cycle 1(1): loaded http://localhost:33085/tests/dromaeo/cssquery-ext.html (next: http://localhost:33085/tests/dromaeo/cssquery-jquery.html) 02:24:57 INFO - PROCESS | 8761 | RSS: Main: 231309312 02:24:57 INFO - PROCESS | 8761 | 02:27:59 INFO - PROCESS | 8761 | Cycle 1(1): loaded http://localhost:33085/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33085/tests/dromaeo/cssquery-mootools.html) 02:27:59 INFO - PROCESS | 8761 | RSS: Main: 228421632 02:27:59 INFO - PROCESS | 8761 | 02:31:01 INFO - PROCESS | 8761 | Cycle 1(1): loaded http://localhost:33085/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33085/tests/dromaeo/cssquery-prototype.html) 02:31:02 INFO - PROCESS | 8761 | RSS: Main: 211750912 02:31:02 INFO - PROCESS | 8761 | 02:34:05 INFO - PROCESS | 8761 | Cycle 1(1): loaded http://localhost:33085/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33085/tests/dromaeo/cssquery-yui.html) 02:34:05 INFO - PROCESS | 8761 | RSS: Main: 206761984 02:34:05 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | Cycle 1(1): loaded http://localhost:33085/tests/dromaeo/cssquery-yui.html (next: http://localhost:33085/tests/dromaeo/cssquery-dojo.html) 02:37:08 INFO - PROCESS | 8761 | RSS: Main: 261844992 02:37:08 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | __start_tp_report 02:37:08 INFO - PROCESS | 8761 | _x_x_mozilla_page_load 02:37:08 INFO - PROCESS | 8761 | _x_x_mozilla_page_load_details 02:37:08 INFO - PROCESS | 8761 | |i|pagename|runs| 02:37:08 INFO - PROCESS | 8761 | |0;dojo.html;2565.884535195916;2643.3920198354367;2643.8545879976596;2653.4958357911996;2680.731926807319;4356.302991521357;4432.468103827545;4475.619572336352;4482.125985432842;4510.391097201881;4514.052049069699;4529.34324522944;4530.3883975663275;4583.381243532122;4613.492515823256;4151.045259590296;4174.895627609304;4178.958210417903;4186.895327616803;4270.210011147932;4001.0797516571206;4185.0583618685705;4214.115035842477;4232.6613870890405;4259.275923093066;4069.023434375758;4115.629593336614;4148.958510414887;4163.521195062576;4179.017930786263;4144.834206631731;4149.398337241113;4156.542780294165;4164.8125834337525;4192.413062171298;4010.278149933011;4081.163361510883;4148.066684995882;4156.521999970012;4189.62293393593;4439.889002774924;4449.332600109977;4453.799579018952;4470.977645111786;4491.214037543416;4788.904221915543;4809.95190048102;4816.964352664159;4874.683145595525;4877.292792545061;4701.600363969067;4799.544043315915;4839.419269687624;4844.927326090112;4888.560029597354;4493.348464472633;4517.299818528133;4528.252838281646;4534.342520334533;4571.38286331341;4740.502247264057;4961.255811628284;4971.90056198874;4975.502449755068;5010.724410157403;4744.715317080986;4758.476567577563;4759.23852183649;4761.40482439695;4806.351142595705;4801.615870730333;4825.059113472839;4825.541573550507;4830.227163653799;4841.031793641286;4579.358889755437;4772.594329482033;4774.236122220428;4824.807007719722;4873.926891096637;4720.480747117815;4721.268203428474;4733;4734.005858769697;4777.092352453023;4050.736702114353;4057.472528571267;4060.4721386219603;4090.6318431341324;4090.7136500445276;3474.6004209515722;3539.415996360623;3568.839402226906;3588.515550400715;3622.239329740784;4120.649744771668;4123.092919557693;4128.071183983579;4147.419361289422;4164.875053748392;4679.064187162581;4796.304535842283;4849.58778503824;4851.393575803025;4899.902001959941;4070.3080476319096;4107.240160570304;4113.773742444135;4146.958530414718;4151.0037590977945;4285.442892423965;4298.032942587893;4313.396124542566;4317.0934103838545;4341.283688191476;4396.12077584478;4486.327050942385;4503.437070366204;4542.841000564964;4584.839530616412;4820.373351464287;4839.830605928775;4844.2007068833245;4849.4908034655855;4883.584895283941;4483.506814250495;4503.076869241863;4521.502634710114;4523.97738011321;4565.794539245809;4635.142498637762;4712.787924543335;4751.287306903992;4763.190257656276;4810.182269014346;4762.190427627381;4776.904461910673;4807.495213002584;4815.422149342101;4848.466668666373;4539.977300113478;4654.1912075350865;4666.113438446684;4674.11191873543;4714.717116972993;4614.492405835288;4615.284630882219;4623.676342655982;4624.329472226441;4661.463931647768;4555.293929440942;4570.497245302948;4588.105319462673;4601.631869450369;4623.514530974199;4600.861974140781;4678.649101317483;4682.1103990241745;4683.976580117078;4691.577758001797;4529.388532548064;4576.81692732287;4577.908441831079;4639.211334073283;4692.694974826625 02:37:08 INFO - PROCESS | 8761 | |1;ext.html;499.001996007984;534.3267482971455;535.6946540471931;537.3256563013417;542.4250294687631;33766.32467350652;34331.65668343319;34350.48474272882;34367.82816085922;34455.65544344556;36574.45138322927;37392.252154956885;37438.25123497529;37439.25121497569;37440.62559374405;7699.153093159748;7871.960640196791;7878.803029924269;7886.921130788704;7887.802804929894;7679.808004799869;7878.487898286622;7895.921040789576;8070.435069545134;8074.394420418463;8030.437869349148;8106.108328083906;8121.918780812205;8125.796855078611;8126.75619731406;8001.7199398021085;8074.6770129194765;8079.717209897684;8087.474314169619;8095.595220238964;7882.211778822072;7988.121306656263;7994.640241189102;7998.800029999296;8001.479903806234;37083;37612.811935940146;37629.62370376289;37668.434973475145;37683.62316376829;3044.1628552148113;3054.7250747432618;3194;3277.8688852445875;3395.253044330268;29128.708712912812;29534.55698164529;29650.851745741133;29803.403931921457;29867.850660746557;3306.35526072416;3320.568326117613;3324.1855745342305;3344.66553344666;3451.8274086295582;215831;217912;217948;218121;218260;55882;56168;56304.155437668465;56514.434855650914;56561.7171914146;61303.6934815332;61611.383886161464;61763;62324;63183.68408158022;13190.73618527624;13306.600801975956;13335.599932001862;13347;13357.33213339329;10504.317219380715;10537.63118290856;10564;10569.365838049742;10618.36289822613;18686.626267474574;18886.622267554572;18907.52731181704;18966.71549926752;18993.720753509668;7579.658915348822;7764.728234511878;7811.375089992787;7880.763577092696;7910.722274693;824.7649419915415;903.6701603914655;949.8622699708503;1013.1540163963026;1017.1760873692333;23580;24270.635940460907;24369.26892193237;24401.633975490382;24479;848.3976376772438;950.9334346595672;958.8945216026232;977.0717818072859;997.9201663867018;13258.73482530344;13433.66415839612;13452.46190152383;15375.384984600714;15792.36830526789;323863;330206;330408;331122;383620;50785.49214507882;51611.48388516067;51626;51895.74052129715;51984.74007629938;1187.7861984842812;1231.3289257354763;1236.6970092327258;1238.7398646284382;1243.434237421971;23398.64902026505;25709;27272;27816.44367112606;29294.70705293005;41180.1763964725;41297;41970.58029419667;41986.99999999878;42011.579884200764;252227;252568;254710;255010;255527;37760.433593496666;38006;38731.6126838728;38763;39691.60308396879;42319;42325.576744233396;42789.14421711486;43191.35212971745;43405;35193.82403087968;35535.82232088927;36031;36066.27867442689;36137;36001.27997439984;36100.458493122096;36245.27509449743;40104;40483.19033619252;34060.659393405746;34593.48109778405;34869.651303486644;34871.82564087163;34876;30854.691453085183;31126.844365778026;31310;31368.529472058395;31420.685793141776;24253.272401827973;24528.264152075466;24581.385465362793;24900;24923.87538062298 02:37:08 INFO - PROCESS | 8761 | |2;jquery.html;335.4969735584581;339.31627770043366;339.750283541597;341.2032903171095;342.83715235263236;12341.691457713561;12710.110292279522;14939.477118300849;15553.144577048271;15555.144467054308;14788.482403115893;14840.183789891578;15407.15260660666;15411.306491207895;15438.073715577073;4771.7614119293985;4958.504149585049;5009.2486127080865;5011.047900898836;5027.396712394518;3563.6970857477017;4989.750512474362;5426.104692725696;5616.606837521375;5617.578681598876;5545.3622833374075;5550.306211723535;5553.389127196006;5573.470520300585;5614;5538.196961440569;5557.360903496089;5564.610477266593;5704.172894930211;5763.250777398911;5027.572656324217;5052.317937078521;5054.974725126351;5061.16490779021;5063.240513922941;18126.365577204866;18913.810861891343;19517;19560.31538896146;19572.608547828964;1648.8966648223848;1869.6354210928873;1958.3243780895712;2163.7619861815188;2279.9658005129772;8242.258196762321;8501.149885011511;8584.828303433958;11321.264117832314;12130.211536250115;1642.244567498952;1696.414736915762;1739.3216645508262;1753.877228593999;1829.021473511665;55337;56735;56783.86432271373;57260;57874.71062644702;9642.855357169648;9717.465539395402;9738.220942324597;9808.901910980941;9850.310478266452;10134.087932086148;11432.657020289405;12467.688307792378;12476.313802740755;12482.188657737219;5393.541548968303;5539.169124631338;5989.730462129215;7119.644017799089;7164.391026762679;6689.799306020827;6724.731010759515;6751.987201919653;6772.5936443813525;6795.93204067953;3977.9204415911518;4201.852935147255;4217.1776503581505;4258.638015768633;4270.103278311527;1649.397969741036;1725.1977830308967;1742.4249997500795;1745.7992330881857;1750.5448583368416;783.4320117914581;816.8121332093533;843.8902942617543;911.9680811171577;912.8813254277035;14200.786988195185;15645.139517326656;15780.122376051797;15860.92069539668;15974.600634983986;804.6017221475407;829.2826704900218;844.5101840932244;850.7192626433263;854.9615267312986;6304.8423789404715;9069.637214511346;9310.906890931139;9420.95289523548;9434.528273586293;279370;350651;364051;367291;369654;52061;53445;66359;67162;68059;929.3726734454216;949.9810003799886;949.9905000949902;951.0679534056663;963.3401120232663;14095.154290742588;14279.214643194724;14497.4925877598;14524.709505809613;14584.052036617586;31440;31687.618933457456;32150.356992859543;32274.35451290914;33161.50257746087;42512.78743606386;44962.77518612386;45051.549484504736;45271.773641131585;46013.309800353694;6679.332066793476;6847.520673552804;6877.58734475913;6880.139982502187;6929.89605155913;8951.776205594912;10376.429296388771;10506.15950723925;10761.246712730033;10831.729206769895;9268;9439.197668198005;9721.56252968604;9935.354201976848;9946.900530994597;8770.780730481789;8936.374453788172;9376.718698439057;9590.328676992822;9611.183049440875;9148.908510915071;9390.295727820578;9618.567164477476;9688.273379496424;9814.75463113428;6464.547481676425;6592.538522303585;6618.238902526271;6795.626240556817;6813.3527314905;8296.25333719944;9985.101340879355;10034.448105354275;10038.749031274276;10198.235132365251 02:37:08 INFO - PROCESS | 8761 | |3;mootools.html;1219.8841110094538;1365.2422905287565;1386.7919812028194;1485.0447609257574;1703.1058694185558;6939.479539034567;7103.147622285333;7115.928840711591;7135.322144396287;7149.714011439536;6941.305869413056;7109.964450177742;7110.60891650959;7113.751018714346;7122.287771222888;1720.1313336764915;1764.8852824566427;1766.9204885780107;2029;2052.4150617074138;2010.9899450502728;2060.5672808710115;2060.8660437071617;2063.473814177383;2064.1330641130685;2006.1574138861713;2010.4270282969358;2023.372754446119;2026.5946810637931;2055.7327547418813;2013.4463022668738;2020.0101950044373;2020.7878172791793;2022.4438279473188;2026.0983862181188;1883.0678813987165;1937.5253062999514;1939.2436949589671;1943.067327682706;1945.3774792066545;7387;7405.814854628624;7415.369693576053;7426.814329641748;7445.441591880576;4064.8983775405554;4203.07532342884;4206.326987681987;4213.2837417639075;4214.346776249687;2714.3485563464824;2725.3459169799303;2789.5397259452166;2793.594928735322;2808.1294798612494;841.9663213471454;849.562475325208;863.2748491267303;863.7970077031893;886.8182022685398;9947.353422027545;9959.651412200537;9959.75100622483;9959.80080398388;9969.70090897267;3711.981440092782;3740;3747.45661879026;3804.543454785388;3862.8841134766003;8540;8560.400771946028;8576.957115214509;8589.957050214709;8603.741887743377;4104.486939132608;4127.504699436026;4129.380592911088;4133.7106402551535;4141.689373296955;3184.633767116765;3728.813559322023;3741.251749650081;3829.1767270037076;3829.2532956073296;3196.7442604592043;3207.9839600801847;3230.2570408805636;3235.7573182010974;3247.5128730690585;995.5719040812376;1002.7743757654615;1007.2445665750687;1009.8687170667766;1011.1758916483043;1150.327058670687;1171.619223752284;1179.1981452612135;1182.562451892788;1187.7861984842812;6768.120144381199;6884.345987131214;6910.550814197061;6912.965435172792;6959.860802783916;941.1764705882352;953.4088864903804;1051.3534176481562;1061.2093989977516;1071.2180108520824;5275.709835958983;5318.308619879391;5325.360956685223;5329.786808527693;5393.649412788156;8335.833283334421;8529.445586036887;8591.398602097917;8591.5704214789;8592.441491303045;8545.743627691056;8894.243989260985;8916.420432671855;8957;8996.64013439455;6782.321767823179;6930.722771089201;6997.895031574531;7006.404455621329;7011.649417529103;6616.8345791355605;6621.900671490028;6687.531872768859;6728.05807187004;6729.0579318894415;7801.882971755542;7861.52830830152;7927.009123859518;8019.879701804594;8100.108988011196;8010.776829815943;8182.22268884455;8273.172682731678;8324;8334.749957501284;5235.869103272448;5750.712464376848;5918.674472904032;5973.462388384893;6012.158297838394;6821.556598821061;6869.278725733926;6887.552309099892;6893.586384816927;6903.551269167488;5859.5019423349495;5985.25184351956;6005.519558435402;6085.3306136325855;6139.539534535017;5891.1752354671235;5920.259967504062;5967.76128954837;6131.540134489842;6142.938570614237;6291.496680265476;6549.672516374258;6550.705218265094;6560.868782624416;6566.277709452052;6034.2155519782145;6145.293291271382;6145.8156255312415;6149.508039356931;6153.538484613582;5865.882682346414;5991.3409524953095;5992.161097446274;6038.245219347582;6046.667433291212 02:37:08 INFO - PROCESS | 8761 | |4;prototype.html;293.6637550005244;298.5924213448643;300.7398600210818;305.11212371997476;306.8266429467349;5317.096093664081;5325.760340784665;5338.839834804957;5358.196270559418;5367.812126575571;5077.771500282487;5182.585393168547;5320.17537281722;5323.254744335786;5331.413544510101;4059.6143366380147;4078.1843631273864;4079.3473044312914;4080.510338759353;4085.101277718897;3903.3364328064154;4079.4084857695766;4086.3870419437026;4086.570910054446;4092.8362865485346;3965.484487016698;4003.15933653933;4014;4015.8795236142814;4016.959830401702;3997.8400863965408;4000.4799376081214;4004.159126583421;4004.2992476316526;4022.859199928018;3560.483729859156;3560.483729859182;3560.537130173061;3563.6436356364416;3570.553680789901;5148.2535032420465;5161;5161.69029858206;5167.354080739908;5176.197689358118;4683.976580117112;4689.88275293117;4694.319323698045;4696.788644511005;4698.201305777991;5416.160495123262;5559.972200138974;5572;5581.832545023656;5583.3300003999375;3832.770033797981;3858.884233473;3861.3049651062797;3862.4550179927974;3874.2057878134915;5834.27071616048;5841.948449279128;5848.824535263949;5850.736716847752;5853.85365365865;3897.590752970954;3924.372100463969;3925.666318362971;3925.8822235332987;3947.822347994347;3996.8201430935096;4004.0790618157985;4022.63230501625;4024.8188831502653;4025.8590949316635;4608.631309495232;4619.122366750306;4624.28323609841;4628.39830821991;4631.421072365954;5533.806316778974;5556.166575013699;5557.166425036277;5559.388467268678;5560.582956278215;1325.9867401326055;1329.3486191766158;1347.8584748601452;1352.1211212711817;1353.1069494133824;902.9187373136449;905.2622112977901;914.4193437167446;916.244098618629;922.280621115531;4746.857594272177;4752.7623618818925;4783.569478746929;4813.807447702123;4829.034193161382;5728.885422291531;5729;5734.62724922887;5739.253896993448;5739.311282646026;4776.331313616097;4809.927851082237;4816.759162041884;4819.445763737145;4827.348307978448;3069.3554353585996;3102.705243001911;3104.068779366181;3106.0526539405696;3108.9844550777552;5284.260203571503;5297.54970827484;5314.893702125936;5339.466053394707;5341.572674186055;5689.402612725687;5862.589618726648;5875.794347197913;5879.559033072536;5893.5579831512805;5299.099153143975;5325.627206095536;5330.7068111253475;5332.9733351333;5336.546393556436;5711.571632127524;5716.714164291852;5720.570957178145;5721.685307308138;5724.255846740064;5559.805406810742;5575.107982722745;5576.86057848557;5585.5252303553025;5591.133374326986;5331.653442526223;5335.67985920846;5336.412994570516;5345.9465405345445;5349.331333583302;3814.9427758584197;3934.1738234970976;3936.645701886844;3938.9015274618364;3939.704522160907;5531.695756733418;5689.032864412977;5703.857403564944;5710.942890571041;5717.571182161271;5433.9184912225555;5532.446755324597;5550.167474878801;5635.605507614428;5638.323401191883;5289.550388217045;5399;5400;5409.242706021081;5582.692951887685;5360.919586206132;5518.972405137949;5521.337439507285;5524.171374293888;5532.30846144232;5634.661920284796;5652.604317697722;5653.236813030188;5663.603547751783;5669.489745922887;5516.448355164452;5526.563093595613;5528.585356098389;5528.889422211453;5531.280933478622 02:37:08 INFO - PROCESS | 8761 | |5;yui.html;629.581328416603;702.1714377035097;736.797380720302;743.2678811370802;743.6765007221856;11430.485628146733;11552.595659151932;11581;11582.710432239199;11593.24643898147;11129.944350278258;11145.554177832897;11217.158713096509;11221.04621107205;11919.106067044962;614.9446549810516;781.6287263549825;794.9205079492062;801.527099011583;802.314021511608;777.8405426887474;790.2097902097902;793.3217099380033;796.9880451793227;797;824.8968878890139;824.9463784853965;825.6986200037003;826.2068414322258;826.6734639817269;633.1389310537688;806.9677212911536;815.3925325632382;817.599376305609;824.0482243009334;601.8375038739516;604.9637021778707;605.1074664869327;605.3643674142133;605.5065121925617;11831.112666550043;11919.642410727693;11920;11924.642260732191;11939.462724177432;11328.886711132865;11864.110191735654;12494.75010499794;12592.68518287041;12699.238045717286;9675.37110087849;9770.914948197296;9926.702198934043;9977.850332245021;9981.950090249502;3260.4457242268873;3301.5212794144713;3319.7842140261046;3326.933461330784;3346.297277571713;41239.58760412387;41367;41481.585184148076;41485;41673.583264167275;9291.303152263607;9327.486988215578;9485.762855928519;9564.521773911276;9643.132118109404;15584.610384740245;15659.686806264039;15741.370345186293;15744.60638484047;15756;6248.5313601479165;6688.33116688337;6728.932710672831;6887.965560172267;6954.617496037666;3530.5586801649793;3537.9469307959885;3557.1285035166034;3563.394222982099;3661.1579336752166;2702.297402675279;2718.388362618395;2722.7141150178945;2736.1244401791237;2740.397112635217;429.3195285472499;448.3566082671377;453.3562341475113;470.2616891480343;489.11470238867764;447.4116536754158;464.99096959597756;586.0798546282381;587.873607174451;593.0311366263962;7305.4886157969495;7545.886811697829;7629.580373079423;8745.693900713444;8760.4743715376;553.7784886045533;560.0646919644204;586.806353903211;600.7687040489443;611.9265688117365;3554.3424466473784;3672.742907996468;3743.981280093582;3814.4469051987307;3862.1889403225637;51917.22124168141;52083;52708;52711.736441317546;52803.47196527985;46886.76556617195;47167.76416117897;47801;48100;48281.51718482841;41495.37756933648;41936.790316048835;42461.57538424576;42593;42920;8095.433319667803;8109.351251899716;8151.551664658264;8212.917870821215;8232.300254478436;30802.845985769927;31059.84470077635;31134.22164445907;31272.37455250837;31754.20614484564;36126.819365903;36251.09372265715;36718.632813671524;39460.2107957845;39575;10080.294379393372;10247.128994035293;10330.948345258226;10331;10463.267571269938;9747.902520974983;10101.242406819665;10674.306170098918;10860.185486088732;11438.199326047097;10873.347599144077;10974.286671366335;10986.560537578727;11203.719907002063;11430.657080287605;10836.891631083588;10861.565537378416;11280.379579123228;11353;11401.714957125807;10528;10558.472076396303;10572.89427105719;10785.40680262593;11173.944130279622;8803.471791692518;8981.14679105484;9155.587998540215;9213.262938964732;9338.95330523343;9230.261579073793;9340.784558524989;9386.436813791195;9429.62281508732;9525.333226674344 02:37:08 INFO - PROCESS | 8761 | __end_tp_report 02:37:08 INFO - PROCESS | 8761 | __start_cc_report 02:37:08 INFO - PROCESS | 8761 | _x_x_mozilla_cycle_collect,998 02:37:08 INFO - PROCESS | 8761 | __end_cc_report 02:37:08 INFO - PROCESS | 8761 | __startTimestamp1456396628926__endTimestamp 02:37:08 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | ------- Summary: start ------- 02:37:08 INFO - PROCESS | 8761 | Number of tests: 6 02:37:08 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | [#0] dojo.html Cycles:165 Average:4443.73 Median:4555.29 stddev:447.80 (9.8%) stddev-sans-first:424.25 02:37:08 INFO - PROCESS | 8761 | Values: 2565.9 2643.4 2643.9 2653.5 2680.7 4356.3 4432.5 4475.6 4482.1 4510.4 4514.1 4529.3 4530.4 4583.4 4613.5 4151.0 4174.9 4179.0 4186.9 4270.2 4001.1 4185.1 4214.1 4232.7 4259.3 4069.0 4115.6 4149.0 4163.5 4179.0 4144.8 4149.4 4156.5 4164.8 4192.4 4010.3 4081.2 4148.1 4156.5 4189.6 4439.9 4449.3 4453.8 4471.0 4491.2 4788.9 4810.0 4817.0 4874.7 4877.3 4701.6 4799.5 4839.4 4844.9 4888.6 4493.3 4517.3 4528.3 4534.3 4571.4 4740.5 4961.3 4971.9 4975.5 5010.7 4744.7 4758.5 4759.2 4761.4 4806.4 4801.6 4825.1 4825.5 4830.2 4841.0 4579.4 4772.6 4774.2 4824.8 4873.9 4720.5 4721.3 4733.0 4734.0 4777.1 4050.7 4057.5 4060.5 4090.6 4090.7 3474.6 3539.4 3568.8 3588.5 3622.2 4120.6 4123.1 4128.1 4147.4 4164.9 4679.1 4796.3 4849.6 4851.4 4899.9 4070.3 4107.2 4113.8 4147.0 4151.0 4285.4 4298.0 4313.4 4317.1 4341.3 4396.1 4486.3 4503.4 4542.8 4584.8 4820.4 4839.8 4844.2 4849.5 4883.6 4483.5 4503.1 4521.5 4524.0 4565.8 4635.1 4712.8 4751.3 4763.2 4810.2 4762.2 4776.9 4807.5 4815.4 4848.5 4540.0 4654.2 4666.1 4674.1 4714.7 4614.5 4615.3 4623.7 4624.3 4661.5 4555.3 4570.5 4588.1 4601.6 4623.5 4600.9 4678.6 4682.1 4684.0 4691.6 4529.4 4576.8 4577.9 4639.2 4692.7 02:37:08 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | [#1] ext.html Cycles:180 Average:43694.68 Median:36083.37 stddev:72228.16 (200.2%) stddev-sans-first:72357.96 02:37:08 INFO - PROCESS | 8761 | Values: 499.0 534.3 535.7 537.3 542.4 33766.3 34331.7 34350.5 34367.8 34455.7 36574.5 37392.3 37438.3 37439.3 37440.6 7699.2 7872.0 7878.8 7886.9 7887.8 7679.8 7878.5 7895.9 8070.4 8074.4 8030.4 8106.1 8121.9 8125.8 8126.8 8001.7 8074.7 8079.7 8087.5 8095.6 7882.2 7988.1 7994.6 7998.8 8001.5 37083.0 37612.8 37629.6 37668.4 37683.6 3044.2 3054.7 3194.0 3277.9 3395.3 29128.7 29534.6 29650.9 29803.4 29867.9 3306.4 3320.6 3324.2 3344.7 3451.8 215831.0 217912.0 217948.0 218121.0 218260.0 55882.0 56168.0 56304.2 56514.4 56561.7 61303.7 61611.4 61763.0 62324.0 63183.7 13190.7 13306.6 13335.6 13347.0 13357.3 10504.3 10537.6 10564.0 10569.4 10618.4 18686.6 18886.6 18907.5 18966.7 18993.7 7579.7 7764.7 7811.4 7880.8 7910.7 824.8 903.7 949.9 1013.2 1017.2 23580.0 24270.6 24369.3 24401.6 24479.0 848.4 950.9 958.9 977.1 997.9 13258.7 13433.7 13452.5 15375.4 15792.4 323863.0 330206.0 330408.0 331122.0 383620.0 50785.5 51611.5 51626.0 51895.7 51984.7 1187.8 1231.3 1236.7 1238.7 1243.4 23398.6 25709.0 27272.0 27816.4 29294.7 41180.2 41297.0 41970.6 41987.0 42011.6 252227.0 252568.0 254710.0 255010.0 255527.0 37760.4 38006.0 38731.6 38763.0 39691.6 42319.0 42325.6 42789.1 43191.4 43405.0 35193.8 35535.8 36031.0 36066.3 36137.0 36001.3 36100.5 36245.3 40104.0 40483.2 34060.7 34593.5 34869.7 34871.8 34876.0 30854.7 31126.8 31310.0 31368.5 31420.7 24253.3 24528.3 24581.4 24900.0 24923.9 02:37:08 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | [#2] jquery.html Cycles:180 Average:21487.31 Median:28562.12 stddev:57157.68 (200.1%) stddev-sans-first:57295.96 02:37:08 INFO - PROCESS | 8761 | Values: 335.5 339.3 339.8 341.2 342.8 12341.7 12710.1 14939.5 15553.1 15555.1 14788.5 14840.2 15407.2 15411.3 15438.1 4771.8 4958.5 5009.2 5011.0 5027.4 3563.7 4989.8 5426.1 5616.6 5617.6 5545.4 5550.3 5553.4 5573.5 5614.0 5538.2 5557.4 5564.6 5704.2 5763.3 5027.6 5052.3 5055.0 5061.2 5063.2 18126.4 18913.8 19517.0 19560.3 19572.6 1648.9 1869.6 1958.3 2163.8 2280.0 8242.3 8501.1 8584.8 11321.3 12130.2 1642.2 1696.4 1739.3 1753.9 1829.0 55337.0 56735.0 56783.9 57260.0 57874.7 9642.9 9717.5 9738.2 9808.9 9850.3 10134.1 11432.7 12467.7 12476.3 12482.2 5393.5 5539.2 5989.7 7119.6 7164.4 6689.8 6724.7 6752.0 6772.6 6795.9 3977.9 4201.9 4217.2 4258.6 4270.1 1649.4 1725.2 1742.4 1745.8 1750.5 783.4 816.8 843.9 912.0 912.9 14200.8 15645.1 15780.1 15860.9 15974.6 804.6 829.3 844.5 850.7 855.0 6304.8 9069.6 9310.9 9421.0 9434.5 279370.0 350651.0 364051.0 367291.0 369654.0 52061.0 53445.0 66359.0 67162.0 68059.0 929.4 950.0 950.0 951.1 963.3 14095.2 14279.2 14497.5 14524.7 14584.1 31440.0 31687.6 32150.4 32274.4 33161.5 42512.8 44962.8 45051.5 45271.8 46013.3 6679.3 6847.5 6877.6 6880.1 6929.9 8951.8 10376.4 10506.2 10761.2 10831.7 9268.0 9439.2 9721.6 9935.4 9946.9 8770.8 8936.4 9376.7 9590.3 9611.2 9148.9 9390.3 9618.6 9688.3 9814.8 6464.5 6592.5 6618.2 6795.6 6813.4 8296.3 9985.1 10034.4 10038.7 10198.2 02:37:08 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | [#3] mootools.html Cycles:180 Average:4997.89 Median:6023.19 stddev:2666.00 (44.3%) stddev-sans-first:2658.36 02:37:08 INFO - PROCESS | 8761 | Values: 1219.9 1365.2 1386.8 1485.0 1703.1 6939.5 7103.1 7115.9 7135.3 7149.7 6941.3 7110.0 7110.6 7113.8 7122.3 1720.1 1764.9 1766.9 2029.0 2052.4 2011.0 2060.6 2060.9 2063.5 2064.1 2006.2 2010.4 2023.4 2026.6 2055.7 2013.4 2020.0 2020.8 2022.4 2026.1 1883.1 1937.5 1939.2 1943.1 1945.4 7387.0 7405.8 7415.4 7426.8 7445.4 4064.9 4203.1 4206.3 4213.3 4214.3 2714.3 2725.3 2789.5 2793.6 2808.1 842.0 849.6 863.3 863.8 886.8 9947.4 9959.7 9959.8 9959.8 9969.7 3712.0 3740.0 3747.5 3804.5 3862.9 8540.0 8560.4 8577.0 8590.0 8603.7 4104.5 4127.5 4129.4 4133.7 4141.7 3184.6 3728.8 3741.3 3829.2 3829.3 3196.7 3208.0 3230.3 3235.8 3247.5 995.6 1002.8 1007.2 1009.9 1011.2 1150.3 1171.6 1179.2 1182.6 1187.8 6768.1 6884.3 6910.6 6913.0 6959.9 941.2 953.4 1051.4 1061.2 1071.2 5275.7 5318.3 5325.4 5329.8 5393.6 8335.8 8529.4 8591.4 8591.6 8592.4 8545.7 8894.2 8916.4 8957.0 8996.6 6782.3 6930.7 6997.9 7006.4 7011.6 6616.8 6621.9 6687.5 6728.1 6729.1 7801.9 7861.5 7927.0 8019.9 8100.1 8010.8 8182.2 8273.2 8324.0 8334.7 5235.9 5750.7 5918.7 5973.5 6012.2 6821.6 6869.3 6887.6 6893.6 6903.6 5859.5 5985.3 6005.5 6085.3 6139.5 5891.2 5920.3 5967.8 6131.5 6142.9 6291.5 6549.7 6550.7 6560.9 6566.3 6034.2 6145.3 6145.8 6149.5 6153.5 5865.9 5991.3 5992.2 6038.2 6046.7 02:37:08 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | [#4] prototype.html Cycles:180 Average:4578.72 Median:5307.00 stddev:1357.91 (25.6%) stddev-sans-first:1323.08 02:37:08 INFO - PROCESS | 8761 | Values: 293.7 298.6 300.7 305.1 306.8 5317.1 5325.8 5338.8 5358.2 5367.8 5077.8 5182.6 5320.2 5323.3 5331.4 4059.6 4078.2 4079.3 4080.5 4085.1 3903.3 4079.4 4086.4 4086.6 4092.8 3965.5 4003.2 4014.0 4015.9 4017.0 3997.8 4000.5 4004.2 4004.3 4022.9 3560.5 3560.5 3560.5 3563.6 3570.6 5148.3 5161.0 5161.7 5167.4 5176.2 4684.0 4689.9 4694.3 4696.8 4698.2 5416.2 5560.0 5572.0 5581.8 5583.3 3832.8 3858.9 3861.3 3862.5 3874.2 5834.3 5841.9 5848.8 5850.7 5853.9 3897.6 3924.4 3925.7 3925.9 3947.8 3996.8 4004.1 4022.6 4024.8 4025.9 4608.6 4619.1 4624.3 4628.4 4631.4 5533.8 5556.2 5557.2 5559.4 5560.6 1326.0 1329.3 1347.9 1352.1 1353.1 902.9 905.3 914.4 916.2 922.3 4746.9 4752.8 4783.6 4813.8 4829.0 5728.9 5729.0 5734.6 5739.3 5739.3 4776.3 4809.9 4816.8 4819.4 4827.3 3069.4 3102.7 3104.1 3106.1 3109.0 5284.3 5297.5 5314.9 5339.5 5341.6 5689.4 5862.6 5875.8 5879.6 5893.6 5299.1 5325.6 5330.7 5333.0 5336.5 5711.6 5716.7 5720.6 5721.7 5724.3 5559.8 5575.1 5576.9 5585.5 5591.1 5331.7 5335.7 5336.4 5345.9 5349.3 3814.9 3934.2 3936.6 3938.9 3939.7 5531.7 5689.0 5703.9 5710.9 5717.6 5433.9 5532.4 5550.2 5635.6 5638.3 5289.6 5399.0 5400.0 5409.2 5582.7 5360.9 5519.0 5521.3 5524.2 5532.3 5634.7 5652.6 5653.2 5663.6 5669.5 5516.4 5526.6 5528.6 5528.9 5531.3 02:37:08 INFO - PROCESS | 8761 | 02:37:08 INFO - PROCESS | 8761 | [#5] yui.html Cycles:180 Average:12477.75 Median:447.88 stddev:14256.66 (3183.1%) stddev-sans-first:14268.89 02:37:08 INFO - PROCESS | 8761 | Values: 629.6 702.2 736.8 743.3 743.7 11430.5 11552.6 11581.0 11582.7 11593.2 11129.9 11145.6 11217.2 11221.0 11919.1 614.9 781.6 794.9 801.5 802.3 777.8 790.2 793.3 797.0 797.0 824.9 824.9 825.7 826.2 826.7 633.1 807.0 815.4 817.6 824.0 601.8 605.0 605.1 605.4 605.5 11831.1 11919.6 11920.0 11924.6 11939.5 11328.9 11864.1 12494.8 12592.7 12699.2 9675.4 9770.9 9926.7 9977.9 9982.0 3260.4 3301.5 3319.8 3326.9 3346.3 41239.6 41367.0 41481.6 41485.0 41673.6 9291.3 9327.5 9485.8 9564.5 9643.1 15584.6 15659.7 15741.4 15744.6 15756.0 6248.5 6688.3 6728.9 6888.0 6954.6 3530.6 3537.9 3557.1 3563.4 3661.2 2702.3 2718.4 2722.7 2736.1 2740.4 429.3 448.4 453.4 470.3 489.1 447.4 465.0 586.1 587.9 593.0 7305.5 7545.9 7629.6 8745.7 8760.5 553.8 560.1 586.8 600.8 611.9 3554.3 3672.7 3744.0 3814.4 3862.2 51917.2 52083.0 52708.0 52711.7 52803.5 46886.8 47167.8 47801.0 48100.0 48281.5 41495.4 41936.8 42461.6 42593.0 42920.0 8095.4 8109.4 8151.6 8212.9 8232.3 30802.8 31059.8 31134.2 31272.4 31754.2 36126.8 36251.1 36718.6 39460.2 39575.0 10080.3 10247.1 10330.9 10331.0 10463.3 9747.9 10101.2 10674.3 10860.2 11438.2 10873.3 10974.3 10986.6 11203.7 11430.7 10836.9 10861.6 11280.4 11353.0 11401.7 10528.0 10558.5 10572.9 10785.4 11173.9 8803.5 8981.1 9155.6 9213.3 9339.0 9230.3 9340.8 9386.4 9429.6 9525.3 02:37:08 INFO - PROCESS | 8761 | -------- Summary: end -------- 02:37:08 INFO - PROCESS | 8761 | 02:37:09 INFO - TEST-INFO | 8761: exit 0 02:37:09 INFO - TEST-OK | dromaeo_css | took 1118157ms 02:37:09 INFO - TEST-START | kraken 02:37:09 INFO - operating with platform_type : linux_ 02:37:09 INFO - Initialising browser for kraken test... 02:37:09 INFO - TEST-INFO | started process 8941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRLkT2T/profile http://localhost:33085/getInfo.html) 02:37:14 INFO - PROCESS | 8941 | __metrics Screen width/height:1600/1200 02:37:14 INFO - PROCESS | 8941 | colorDepth:24 02:37:14 INFO - PROCESS | 8941 | Browser inner width/height: 1024/697 02:37:14 INFO - PROCESS | 8941 | __metrics 02:37:15 INFO - PROCESS | 8941 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:37:15 INFO - PROCESS | 8941 | 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. 02:37:16 INFO - TEST-INFO | 8941: exit 0 02:37:16 INFO - Browser initialized. 02:37:16 INFO - Running cycle 1/1 for kraken test... 02:37:16 INFO - TEST-INFO | started process 9024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRLkT2T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:28 INFO - PROCESS | 9024 | RSS: Main: 147763200 02:37:28 INFO - PROCESS | 9024 | 02:37:31 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33085/tests/kraken/driver.html?testName=audio-beat-detection) 02:37:31 INFO - PROCESS | 9024 | RSS: Main: 192966656 02:37:31 INFO - PROCESS | 9024 | 02:37:34 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33085/tests/kraken/driver.html?testName=audio-dft) 02:37:35 INFO - PROCESS | 9024 | RSS: Main: 181170176 02:37:35 INFO - PROCESS | 9024 | 02:37:38 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33085/tests/kraken/driver.html?testName=audio-fft) 02:37:38 INFO - PROCESS | 9024 | RSS: Main: 167301120 02:37:38 INFO - PROCESS | 9024 | 02:37:40 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33085/tests/kraken/driver.html?testName=audio-oscillator) 02:37:41 INFO - PROCESS | 9024 | RSS: Main: 168112128 02:37:41 INFO - PROCESS | 9024 | 02:37:43 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33085/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:37:44 INFO - PROCESS | 9024 | RSS: Main: 168214528 02:37:44 INFO - PROCESS | 9024 | 02:37:47 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33085/tests/kraken/driver.html?testName=imaging-darkroom) 02:37:48 INFO - PROCESS | 9024 | RSS: Main: 170115072 02:37:48 INFO - PROCESS | 9024 | 02:37:51 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33085/tests/kraken/driver.html?testName=imaging-desaturate) 02:37:52 INFO - PROCESS | 9024 | RSS: Main: 170291200 02:37:52 INFO - PROCESS | 9024 | 02:37:54 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33085/tests/kraken/driver.html?testName=json-parse-financial) 02:37:55 INFO - PROCESS | 9024 | RSS: Main: 170418176 02:37:55 INFO - PROCESS | 9024 | 02:37:57 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33085/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:37:57 INFO - PROCESS | 9024 | RSS: Main: 181288960 02:37:57 INFO - PROCESS | 9024 | 02:37:59 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33085/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:38:00 INFO - PROCESS | 9024 | RSS: Main: 181592064 02:38:00 INFO - PROCESS | 9024 | 02:38:02 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33085/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:38:03 INFO - PROCESS | 9024 | RSS: Main: 193400832 02:38:03 INFO - PROCESS | 9024 | 02:38:05 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:38:06 INFO - PROCESS | 9024 | RSS: Main: 200200192 02:38:06 INFO - PROCESS | 9024 | 02:38:08 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:38:09 INFO - PROCESS | 9024 | RSS: Main: 198066176 02:38:09 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | Cycle 1(1): loaded http://localhost:33085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33085/tests/kraken/driver.html?testName=ai-astar) 02:38:11 INFO - PROCESS | 9024 | RSS: Main: 259911680 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | __start_tp_report 02:38:11 INFO - PROCESS | 9024 | _x_x_mozilla_page_load 02:38:11 INFO - PROCESS | 9024 | _x_x_mozilla_page_load_details 02:38:11 INFO - PROCESS | 9024 | |i|pagename|runs| 02:38:11 INFO - PROCESS | 9024 | |0;ai-astar;114;116;110;116;116;116;105;114;117;114 02:38:11 INFO - PROCESS | 9024 | |1;audio-beat-detection;173;132;162;179;136;155;165;136;169;136 02:38:11 INFO - PROCESS | 9024 | |2;audio-dft;163;162;162;170;162;164;163;163;162;164 02:38:11 INFO - PROCESS | 9024 | |3;audio-fft;74;75;106;103;74;73;73;122;107;75 02:38:11 INFO - PROCESS | 9024 | |4;audio-oscillator;98;98;130;97;97;98;139;97;98;137 02:38:11 INFO - PROCESS | 9024 | |5;imaging-gaussian-blur;119;115;115;115;115;114;115;115;115;115 02:38:11 INFO - PROCESS | 9024 | |6;imaging-darkroom;147;147;147;147;147;146;147;146;147;148 02:38:11 INFO - PROCESS | 9024 | |7;imaging-desaturate;96;96;96;96;95;96;95;96;95;96 02:38:11 INFO - PROCESS | 9024 | |8;json-parse-financial;66;66;67;68;65;67;66;76;70;66 02:38:11 INFO - PROCESS | 9024 | |9;json-stringify-tinderbox;71;71;71;71;72;72;71;70;71;71 02:38:11 INFO - PROCESS | 9024 | |10;stanford-crypto-aes;84;84;89;85;87;85;85;86;90;94 02:38:11 INFO - PROCESS | 9024 | |11;stanford-crypto-ccm;121;121;127;125;126;120;122;123;125;124 02:38:11 INFO - PROCESS | 9024 | |12;stanford-crypto-pbkdf2;165;137;150;148;148;137;151;149;146;149 02:38:11 INFO - PROCESS | 9024 | |13;stanford-crypto-sha256-iterative;74;71;75;80;71;70;70;70;71;71 02:38:11 INFO - PROCESS | 9024 | __end_tp_report 02:38:11 INFO - PROCESS | 9024 | __start_cc_report 02:38:11 INFO - PROCESS | 9024 | _x_x_mozilla_cycle_collect,1015 02:38:11 INFO - PROCESS | 9024 | __end_cc_report 02:38:11 INFO - PROCESS | 9024 | __startTimestamp1456396691537__endTimestamp 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | ------- Summary: start ------- 02:38:11 INFO - PROCESS | 9024 | Number of tests: 14 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#0] ai-astar Cycles:10 Average:113.80 Median:116.00 stddev:3.68 (3.2%) stddev-sans-first:3.90 02:38:11 INFO - PROCESS | 9024 | Values: 114.0 116.0 110.0 116.0 116.0 116.0 105.0 114.0 117.0 114.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:163.50 stddev:17.80 (10.9%) stddev-sans-first:17.55 02:38:11 INFO - PROCESS | 9024 | Values: 173.0 132.0 162.0 179.0 136.0 155.0 165.0 136.0 169.0 136.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.42 (1.5%) stddev-sans-first:2.55 02:38:11 INFO - PROCESS | 9024 | Values: 163.0 162.0 162.0 170.0 162.0 164.0 163.0 163.0 162.0 164.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#3] audio-fft Cycles:10 Average:88.20 Median:73.50 stddev:18.99 (25.8%) stddev-sans-first:19.43 02:38:11 INFO - PROCESS | 9024 | Values: 74.0 75.0 106.0 103.0 74.0 73.0 73.0 122.0 107.0 75.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:97.50 stddev:18.38 (18.9%) stddev-sans-first:19.07 02:38:11 INFO - PROCESS | 9024 | Values: 98.0 98.0 130.0 97.0 97.0 98.0 139.0 97.0 98.0 137.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.34 (1.2%) stddev-sans-first:0.33 02:38:11 INFO - PROCESS | 9024 | Values: 119.0 115.0 115.0 115.0 115.0 114.0 115.0 115.0 115.0 115.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:38:11 INFO - PROCESS | 9024 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 148.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:38:11 INFO - PROCESS | 9024 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:67.00 stddev:3.23 (4.8%) stddev-sans-first:3.37 02:38:11 INFO - PROCESS | 9024 | Values: 66.0 66.0 67.0 68.0 65.0 67.0 66.0 76.0 70.0 66.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 02:38:11 INFO - PROCESS | 9024 | Values: 71.0 71.0 71.0 71.0 72.0 72.0 71.0 70.0 71.0 71.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.50 stddev:3.21 (3.7%) stddev-sans-first:3.23 02:38:11 INFO - PROCESS | 9024 | Values: 84.0 84.0 89.0 85.0 87.0 85.0 85.0 86.0 90.0 94.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:124.50 stddev:2.37 (1.9%) stddev-sans-first:2.35 02:38:11 INFO - PROCESS | 9024 | Values: 121.0 121.0 127.0 125.0 126.0 120.0 122.0 123.0 125.0 124.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:149.00 stddev:7.82 (5.2%) stddev-sans-first:5.35 02:38:11 INFO - PROCESS | 9024 | Values: 165.0 137.0 150.0 148.0 148.0 137.0 151.0 149.0 146.0 149.0 02:38:11 INFO - PROCESS | 9024 | 02:38:11 INFO - PROCESS | 9024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:71.00 stddev:3.20 (4.5%) stddev-sans-first:3.33 02:38:11 INFO - PROCESS | 9024 | Values: 74.0 71.0 75.0 80.0 71.0 70.0 70.0 70.0 71.0 71.0 02:38:11 INFO - PROCESS | 9024 | -------- Summary: end -------- 02:38:11 INFO - PROCESS | 9024 | 02:38:12 INFO - TEST-INFO | 9024: exit 0 02:38:12 INFO - TEST-OK | kraken | took 62829ms 02:38:12 INFO - SUITE-END | took 1180s 02:38:12 INFO - Completed test suite (00:19:41) 02:38:12 INFO - Working with test: dromaeo_css 02:38:12 INFO - Generating results file: dromaeo_css 02:38:12 INFO - Working with test: kraken 02:38:12 INFO - Generating results file: kraken 02:38:12 INFO - javascript benchmark 02:38:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:38:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 02:38:12 INFO - process_Request line: dromaeo_css 6198.69 graph.html#tests=[[72,132,35]] 02:38:12 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:38:12 INFO - process_Request line: kraken 1556.00 graph.html#tests=[[232,132,35]] 02:38:12 INFO - RETURN: dromaeo_css: 6198.69 02:38:12 INFO - RETURN: kraken: 1556.00 02:38:12 INFO - javascript benchmark 02:38:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2565.884535195916, 2643.3920198354367, 2643.8545879976596, 2653.4958357911996, 2680.731926807319, 4356.302991521357, 4432.468103827545, 4475.619572336352, 4482.125985432842, 4510.391097201881, 4514.052049069699, 4529.34324522944, 4530.3883975663275, 4583.381243532122, 4613.492515823256, 4151.045259590296, 4174.895627609304, 4178.958210417903, 4186.895327616803, 4270.210011147932, 4001.0797516571206, 4185.0583618685705, 4214.115035842477, 4232.6613870890405, 4259.275923093066, 4069.023434375758, 4115.629593336614, 4148.958510414887, 4163.521195062576, 4179.017930786263, 4144.834206631731, 4149.398337241113, 4156.542780294165, 4164.8125834337525, 4192.413062171298, 4010.278149933011, 4081.163361510883, 4148.066684995882, 4156.521999970012, 4189.62293393593, 4439.889002774924, 4449.332600109977, 4453.799579018952, 4470.977645111786, 4491.214037543416, 4788.904221915543, 4809.95190048102, 4816.964352664159, 4874.683145595525, 4877.292792545061, 4701.600363969067, 4799.544043315915, 4839.419269687624, 4844.927326090112, 4888.560029597354, 4493.348464472633, 4517.299818528133, 4528.252838281646, 4534.342520334533, 4571.38286331341, 4740.502247264057, 4961.255811628284, 4971.90056198874, 4975.502449755068, 5010.724410157403, 4744.715317080986, 4758.476567577563, 4759.23852183649, 4761.40482439695, 4806.351142595705, 4801.615870730333, 4825.059113472839, 4825.541573550507, 4830.227163653799, 4841.031793641286, 4579.358889755437, 4772.594329482033, 4774.236122220428, 4824.807007719722, 4873.926891096637, 4720.480747117815, 4721.268203428474, 4733.0, 4734.005858769697, 4777.092352453023, 4050.736702114353, 4057.472528571267, 4060.4721386219603, 4090.6318431341324, 4090.7136500445276, 3474.6004209515722, 3539.415996360623, 3568.839402226906, 3588.515550400715, 3622.239329740784, 4120.649744771668, 4123.092919557693, 4128.071183983579, 4147.419361289422, 4164.875053748392, 4679.064187162581, 4796.304535842283, 4849.58778503824, 4851.393575803025, 4899.902001959941, 4070.3080476319096, 4107.240160570304, 4113.773742444135, 4146.958530414718, 4151.0037590977945, 4285.442892423965, 4298.032942587893, 4313.396124542566, 4317.0934103838545, 4341.283688191476, 4396.12077584478, 4486.327050942385, 4503.437070366204, 4542.841000564964, 4584.839530616412, 4820.373351464287, 4839.830605928775, 4844.2007068833245, 4849.4908034655855, 4883.584895283941, 4483.506814250495, 4503.076869241863, 4521.502634710114, 4523.97738011321, 4565.794539245809, 4635.142498637762, 4712.787924543335, 4751.287306903992, 4763.190257656276, 4810.182269014346, 4762.190427627381, 4776.904461910673, 4807.495213002584, 4815.422149342101, 4848.466668666373, 4539.977300113478, 4654.1912075350865, 4666.113438446684, 4674.11191873543, 4714.717116972993, 4614.492405835288, 4615.284630882219, 4623.676342655982, 4624.329472226441, 4661.463931647768, 4555.293929440942, 4570.497245302948, 4588.105319462673, 4601.631869450369, 4623.514530974199, 4600.861974140781, 4678.649101317483, 4682.1103990241745, 4683.976580117078, 4691.577758001797, 4529.388532548064, 4576.81692732287, 4577.908441831079, 4639.211334073283, 4692.694974826625], "unit": "score", "name": "dojo.html", "value": 4417.009360439658}, {"lowerIsBetter": false, "replicates": [499.001996007984, 534.3267482971455, 535.6946540471931, 537.3256563013417, 542.4250294687631, 33766.32467350652, 34331.65668343319, 34350.48474272882, 34367.82816085922, 34455.65544344556, 36574.45138322927, 37392.252154956885, 37438.25123497529, 37439.25121497569, 37440.62559374405, 7699.153093159748, 7871.960640196791, 7878.803029924269, 7886.921130788704, 7887.802804929894, 7679.808004799869, 7878.487898286622, 7895.921040789576, 8070.435069545134, 8074.394420418463, 8030.437869349148, 8106.108328083906, 8121.918780812205, 8125.796855078611, 8126.75619731406, 8001.7199398021085, 8074.6770129194765, 8079.717209897684, 8087.474314169619, 8095.595220238964, 7882.211778822072, 7988.121306656263, 7994.640241189102, 7998.800029999296, 8001.479903806234, 37083.0, 37612.811935940146, 37629.62370376289, 37668.434973475145, 37683.62316376829, 3044.1628552148113, 3054.7250747432618, 3194.0, 3277.8688852445875, 3395.253044330268, 29128.708712912812, 29534.55698164529, 29650.851745741133, 29803.403931921457, 29867.850660746557, 3306.35526072416, 3320.568326117613, 3324.1855745342305, 3344.66553344666, 3451.8274086295582, 215831.0, 217912.0, 217948.0, 218121.0, 218260.0, 55882.0, 56168.0, 56304.155437668465, 56514.434855650914, 56561.7171914146, 61303.6934815332, 61611.383886161464, 61763.0, 62324.0, 63183.68408158022, 13190.73618527624, 13306.600801975956, 13335.599932001862, 13347.0, 13357.33213339329, 10504.317219380715, 10537.63118290856, 10564.0, 10569.365838049742, 10618.36289822613, 18686.626267474574, 18886.622267554572, 18907.52731181704, 18966.71549926752, 18993.720753509668, 7579.658915348822, 7764.728234511878, 7811.375089992787, 7880.763577092696, 7910.722274693, 824.7649419915415, 903.6701603914655, 949.8622699708503, 1013.1540163963026, 1017.1760873692333, 23580.0, 24270.635940460907, 24369.26892193237, 24401.633975490382, 24479.0, 848.3976376772438, 950.9334346595672, 958.8945216026232, 977.0717818072859, 997.9201663867018, 13258.73482530344, 13433.66415839612, 13452.46190152383, 15375.384984600714, 15792.36830526789, 323863.0, 330206.0, 330408.0, 331122.0, 383620.0, 50785.49214507882, 51611.48388516067, 51626.0, 51895.74052129715, 51984.74007629938, 1187.7861984842812, 1231.3289257354763, 1236.6970092327258, 1238.7398646284382, 1243.434237421971, 23398.64902026505, 25709.0, 27272.0, 27816.44367112606, 29294.70705293005, 41180.1763964725, 41297.0, 41970.58029419667, 41986.99999999878, 42011.579884200764, 252227.0, 252568.0, 254710.0, 255010.0, 255527.0, 37760.433593496666, 38006.0, 38731.6126838728, 38763.0, 39691.60308396879, 42319.0, 42325.576744233396, 42789.14421711486, 43191.35212971745, 43405.0, 35193.82403087968, 35535.82232088927, 36031.0, 36066.27867442689, 36137.0, 36001.27997439984, 36100.458493122096, 36245.27509449743, 40104.0, 40483.19033619252, 34060.659393405746, 34593.48109778405, 34869.651303486644, 34871.82564087163, 34876.0, 30854.691453085183, 31126.844365778026, 31310.0, 31368.529472058395, 31420.685793141776, 24253.272401827973, 24528.264152075466, 24581.385465362793, 24900.0, 24923.87538062298], "unit": "score", "name": "ext.html", "value": 17401.33364849825}, {"lowerIsBetter": false, "replicates": [335.4969735584581, 339.31627770043366, 339.750283541597, 341.2032903171095, 342.83715235263236, 12341.691457713561, 12710.110292279522, 14939.477118300849, 15553.144577048271, 15555.144467054308, 14788.482403115893, 14840.183789891578, 15407.15260660666, 15411.306491207895, 15438.073715577073, 4771.7614119293985, 4958.504149585049, 5009.2486127080865, 5011.047900898836, 5027.396712394518, 3563.6970857477017, 4989.750512474362, 5426.104692725696, 5616.606837521375, 5617.578681598876, 5545.3622833374075, 5550.306211723535, 5553.389127196006, 5573.470520300585, 5614.0, 5538.196961440569, 5557.360903496089, 5564.610477266593, 5704.172894930211, 5763.250777398911, 5027.572656324217, 5052.317937078521, 5054.974725126351, 5061.16490779021, 5063.240513922941, 18126.365577204866, 18913.810861891343, 19517.0, 19560.31538896146, 19572.608547828964, 1648.8966648223848, 1869.6354210928873, 1958.3243780895712, 2163.7619861815188, 2279.9658005129772, 8242.258196762321, 8501.149885011511, 8584.828303433958, 11321.264117832314, 12130.211536250115, 1642.244567498952, 1696.414736915762, 1739.3216645508262, 1753.877228593999, 1829.021473511665, 55337.0, 56735.0, 56783.86432271373, 57260.0, 57874.71062644702, 9642.855357169648, 9717.465539395402, 9738.220942324597, 9808.901910980941, 9850.310478266452, 10134.087932086148, 11432.657020289405, 12467.688307792378, 12476.313802740755, 12482.188657737219, 5393.541548968303, 5539.169124631338, 5989.730462129215, 7119.644017799089, 7164.391026762679, 6689.799306020827, 6724.731010759515, 6751.987201919653, 6772.5936443813525, 6795.93204067953, 3977.9204415911518, 4201.852935147255, 4217.1776503581505, 4258.638015768633, 4270.103278311527, 1649.397969741036, 1725.1977830308967, 1742.4249997500795, 1745.7992330881857, 1750.5448583368416, 783.4320117914581, 816.8121332093533, 843.8902942617543, 911.9680811171577, 912.8813254277035, 14200.786988195185, 15645.139517326656, 15780.122376051797, 15860.92069539668, 15974.600634983986, 804.6017221475407, 829.2826704900218, 844.5101840932244, 850.7192626433263, 854.9615267312986, 6304.8423789404715, 9069.637214511346, 9310.906890931139, 9420.95289523548, 9434.528273586293, 279370.0, 350651.0, 364051.0, 367291.0, 369654.0, 52061.0, 53445.0, 66359.0, 67162.0, 68059.0, 929.3726734454216, 949.9810003799886, 949.9905000949902, 951.0679534056663, 963.3401120232663, 14095.154290742588, 14279.214643194724, 14497.4925877598, 14524.709505809613, 14584.052036617586, 31440.0, 31687.618933457456, 32150.356992859543, 32274.35451290914, 33161.50257746087, 42512.78743606386, 44962.77518612386, 45051.549484504736, 45271.773641131585, 46013.309800353694, 6679.332066793476, 6847.520673552804, 6877.58734475913, 6880.139982502187, 6929.89605155913, 8951.776205594912, 10376.429296388771, 10506.15950723925, 10761.246712730033, 10831.729206769895, 9268.0, 9439.197668198005, 9721.56252968604, 9935.354201976848, 9946.900530994597, 8770.780730481789, 8936.374453788172, 9376.718698439057, 9590.328676992822, 9611.183049440875, 9148.908510915071, 9390.295727820578, 9618.567164477476, 9688.273379496424, 9814.75463113428, 6464.547481676425, 6592.538522303585, 6618.238902526271, 6795.626240556817, 6813.3527314905, 8296.25333719944, 9985.101340879355, 10034.448105354275, 10038.749031274276, 10198.235132365251], "unit": "score", "name": "jquery.html", "value": 7626.46815653903}, {"lowerIsBetter": false, "replicates": [1219.8841110094538, 1365.2422905287565, 1386.7919812028194, 1485.0447609257574, 1703.1058694185558, 6939.479539034567, 7103.147622285333, 7115.928840711591, 7135.322144396287, 7149.714011439536, 6941.305869413056, 7109.964450177742, 7110.60891650959, 7113.751018714346, 7122.287771222888, 1720.1313336764915, 1764.8852824566427, 1766.9204885780107, 2029.0, 2052.4150617074138, 2010.9899450502728, 2060.5672808710115, 2060.8660437071617, 2063.473814177383, 2064.1330641130685, 2006.1574138861713, 2010.4270282969358, 2023.372754446119, 2026.5946810637931, 2055.7327547418813, 2013.4463022668738, 2020.0101950044373, 2020.7878172791793, 2022.4438279473188, 2026.0983862181188, 1883.0678813987165, 1937.5253062999514, 1939.2436949589671, 1943.067327682706, 1945.3774792066545, 7387.0, 7405.814854628624, 7415.369693576053, 7426.814329641748, 7445.441591880576, 4064.8983775405554, 4203.07532342884, 4206.326987681987, 4213.2837417639075, 4214.346776249687, 2714.3485563464824, 2725.3459169799303, 2789.5397259452166, 2793.594928735322, 2808.1294798612494, 841.9663213471454, 849.562475325208, 863.2748491267303, 863.7970077031893, 886.8182022685398, 9947.353422027545, 9959.651412200537, 9959.75100622483, 9959.80080398388, 9969.70090897267, 3711.981440092782, 3740.0, 3747.45661879026, 3804.543454785388, 3862.8841134766003, 8540.0, 8560.400771946028, 8576.957115214509, 8589.957050214709, 8603.741887743377, 4104.486939132608, 4127.504699436026, 4129.380592911088, 4133.7106402551535, 4141.689373296955, 3184.633767116765, 3728.813559322023, 3741.251749650081, 3829.1767270037076, 3829.2532956073296, 3196.7442604592043, 3207.9839600801847, 3230.2570408805636, 3235.7573182010974, 3247.5128730690585, 995.5719040812376, 1002.7743757654615, 1007.2445665750687, 1009.8687170667766, 1011.1758916483043, 1150.327058670687, 1171.619223752284, 1179.1981452612135, 1182.562451892788, 1187.7861984842812, 6768.120144381199, 6884.345987131214, 6910.550814197061, 6912.965435172792, 6959.860802783916, 941.1764705882352, 953.4088864903804, 1051.3534176481562, 1061.2093989977516, 1071.2180108520824, 5275.709835958983, 5318.308619879391, 5325.360956685223, 5329.786808527693, 5393.649412788156, 8335.833283334421, 8529.445586036887, 8591.398602097917, 8591.5704214789, 8592.441491303045, 8545.743627691056, 8894.243989260985, 8916.420432671855, 8957.0, 8996.64013439455, 6782.321767823179, 6930.722771089201, 6997.895031574531, 7006.404455621329, 7011.649417529103, 6616.8345791355605, 6621.900671490028, 6687.531872768859, 6728.05807187004, 6729.0579318894415, 7801.882971755542, 7861.52830830152, 7927.009123859518, 8019.879701804594, 8100.108988011196, 8010.776829815943, 8182.22268884455, 8273.172682731678, 8324.0, 8334.749957501284, 5235.869103272448, 5750.712464376848, 5918.674472904032, 5973.462388384893, 6012.158297838394, 6821.556598821061, 6869.278725733926, 6887.552309099892, 6893.586384816927, 6903.551269167488, 5859.5019423349495, 5985.25184351956, 6005.519558435402, 6085.3306136325855, 6139.539534535017, 5891.1752354671235, 5920.259967504062, 5967.76128954837, 6131.540134489842, 6142.938570614237, 6291.496680265476, 6549.672516374258, 6550.705218265094, 6560.868782624416, 6566.277709452052, 6034.2155519782145, 6145.293291271382, 6145.8156255312415, 6149.508039356931, 6153.538484613582, 5865.882682346414, 5991.3409524953095, 5992.161097446274, 6038.245219347582, 6046.667433291212], "unit": "score", "name": "mootools.html", "value": 4068.7432497778877}, {"lowerIsBetter": false, "replicates": [293.6637550005244, 298.5924213448643, 300.7398600210818, 305.11212371997476, 306.8266429467349, 5317.096093664081, 5325.760340784665, 5338.839834804957, 5358.196270559418, 5367.812126575571, 5077.771500282487, 5182.585393168547, 5320.17537281722, 5323.254744335786, 5331.413544510101, 4059.6143366380147, 4078.1843631273864, 4079.3473044312914, 4080.510338759353, 4085.101277718897, 3903.3364328064154, 4079.4084857695766, 4086.3870419437026, 4086.570910054446, 4092.8362865485346, 3965.484487016698, 4003.15933653933, 4014.0, 4015.8795236142814, 4016.959830401702, 3997.8400863965408, 4000.4799376081214, 4004.159126583421, 4004.2992476316526, 4022.859199928018, 3560.483729859156, 3560.483729859182, 3560.537130173061, 3563.6436356364416, 3570.553680789901, 5148.2535032420465, 5161.0, 5161.69029858206, 5167.354080739908, 5176.197689358118, 4683.976580117112, 4689.88275293117, 4694.319323698045, 4696.788644511005, 4698.201305777991, 5416.160495123262, 5559.972200138974, 5572.0, 5581.832545023656, 5583.3300003999375, 3832.770033797981, 3858.884233473, 3861.3049651062797, 3862.4550179927974, 3874.2057878134915, 5834.27071616048, 5841.948449279128, 5848.824535263949, 5850.736716847752, 5853.85365365865, 3897.590752970954, 3924.372100463969, 3925.666318362971, 3925.8822235332987, 3947.822347994347, 3996.8201430935096, 4004.0790618157985, 4022.63230501625, 4024.8188831502653, 4025.8590949316635, 4608.631309495232, 4619.122366750306, 4624.28323609841, 4628.39830821991, 4631.421072365954, 5533.806316778974, 5556.166575013699, 5557.166425036277, 5559.388467268678, 5560.582956278215, 1325.9867401326055, 1329.3486191766158, 1347.8584748601452, 1352.1211212711817, 1353.1069494133824, 902.9187373136449, 905.2622112977901, 914.4193437167446, 916.244098618629, 922.280621115531, 4746.857594272177, 4752.7623618818925, 4783.569478746929, 4813.807447702123, 4829.034193161382, 5728.885422291531, 5729.0, 5734.62724922887, 5739.253896993448, 5739.311282646026, 4776.331313616097, 4809.927851082237, 4816.759162041884, 4819.445763737145, 4827.348307978448, 3069.3554353585996, 3102.705243001911, 3104.068779366181, 3106.0526539405696, 3108.9844550777552, 5284.260203571503, 5297.54970827484, 5314.893702125936, 5339.466053394707, 5341.572674186055, 5689.402612725687, 5862.589618726648, 5875.794347197913, 5879.559033072536, 5893.5579831512805, 5299.099153143975, 5325.627206095536, 5330.7068111253475, 5332.9733351333, 5336.546393556436, 5711.571632127524, 5716.714164291852, 5720.570957178145, 5721.685307308138, 5724.255846740064, 5559.805406810742, 5575.107982722745, 5576.86057848557, 5585.5252303553025, 5591.133374326986, 5331.653442526223, 5335.67985920846, 5336.412994570516, 5345.9465405345445, 5349.331333583302, 3814.9427758584197, 3934.1738234970976, 3936.645701886844, 3938.9015274618364, 3939.704522160907, 5531.695756733418, 5689.032864412977, 5703.857403564944, 5710.942890571041, 5717.571182161271, 5433.9184912225555, 5532.446755324597, 5550.167474878801, 5635.605507614428, 5638.323401191883, 5289.550388217045, 5399.0, 5400.0, 5409.242706021081, 5582.692951887685, 5360.919586206132, 5518.972405137949, 5521.337439507285, 5524.171374293888, 5532.30846144232, 5634.661920284796, 5652.604317697722, 5653.236813030188, 5663.603547751783, 5669.489745922887, 5516.448355164452, 5526.563093595613, 5528.585356098389, 5528.889422211453, 5531.280933478622], "unit": "score", "name": "prototype.html", "value": 4136.444798829462}, {"lowerIsBetter": false, "replicates": [629.581328416603, 702.1714377035097, 736.797380720302, 743.2678811370802, 743.6765007221856, 11430.485628146733, 11552.595659151932, 11581.0, 11582.710432239199, 11593.24643898147, 11129.944350278258, 11145.554177832897, 11217.158713096509, 11221.04621107205, 11919.106067044962, 614.9446549810516, 781.6287263549825, 794.9205079492062, 801.527099011583, 802.314021511608, 777.8405426887474, 790.2097902097902, 793.3217099380033, 796.9880451793227, 797.0, 824.8968878890139, 824.9463784853965, 825.6986200037003, 826.2068414322258, 826.6734639817269, 633.1389310537688, 806.9677212911536, 815.3925325632382, 817.599376305609, 824.0482243009334, 601.8375038739516, 604.9637021778707, 605.1074664869327, 605.3643674142133, 605.5065121925617, 11831.112666550043, 11919.642410727693, 11920.0, 11924.642260732191, 11939.462724177432, 11328.886711132865, 11864.110191735654, 12494.75010499794, 12592.68518287041, 12699.238045717286, 9675.37110087849, 9770.914948197296, 9926.702198934043, 9977.850332245021, 9981.950090249502, 3260.4457242268873, 3301.5212794144713, 3319.7842140261046, 3326.933461330784, 3346.297277571713, 41239.58760412387, 41367.0, 41481.585184148076, 41485.0, 41673.583264167275, 9291.303152263607, 9327.486988215578, 9485.762855928519, 9564.521773911276, 9643.132118109404, 15584.610384740245, 15659.686806264039, 15741.370345186293, 15744.60638484047, 15756.0, 6248.5313601479165, 6688.33116688337, 6728.932710672831, 6887.965560172267, 6954.617496037666, 3530.5586801649793, 3537.9469307959885, 3557.1285035166034, 3563.394222982099, 3661.1579336752166, 2702.297402675279, 2718.388362618395, 2722.7141150178945, 2736.1244401791237, 2740.397112635217, 429.3195285472499, 448.3566082671377, 453.3562341475113, 470.2616891480343, 489.11470238867764, 447.4116536754158, 464.99096959597756, 586.0798546282381, 587.873607174451, 593.0311366263962, 7305.4886157969495, 7545.886811697829, 7629.580373079423, 8745.693900713444, 8760.4743715376, 553.7784886045533, 560.0646919644204, 586.806353903211, 600.7687040489443, 611.9265688117365, 3554.3424466473784, 3672.742907996468, 3743.981280093582, 3814.4469051987307, 3862.1889403225637, 51917.22124168141, 52083.0, 52708.0, 52711.736441317546, 52803.47196527985, 46886.76556617195, 47167.76416117897, 47801.0, 48100.0, 48281.51718482841, 41495.37756933648, 41936.790316048835, 42461.57538424576, 42593.0, 42920.0, 8095.433319667803, 8109.351251899716, 8151.551664658264, 8212.917870821215, 8232.300254478436, 30802.845985769927, 31059.84470077635, 31134.22164445907, 31272.37455250837, 31754.20614484564, 36126.819365903, 36251.09372265715, 36718.632813671524, 39460.2107957845, 39575.0, 10080.294379393372, 10247.128994035293, 10330.948345258226, 10331.0, 10463.267571269938, 9747.902520974983, 10101.242406819665, 10674.306170098918, 10860.185486088732, 11438.199326047097, 10873.347599144077, 10974.286671366335, 10986.560537578727, 11203.719907002063, 11430.657080287605, 10836.891631083588, 10861.565537378416, 11280.379579123228, 11353.0, 11401.714957125807, 10528.0, 10558.472076396303, 10572.89427105719, 10785.40680262593, 11173.944130279622, 8803.471791692518, 8981.14679105484, 9155.587998540215, 9213.262938964732, 9338.95330523343, 9230.261579073793, 9340.784558524989, 9386.436813791195, 9429.62281508732, 9525.333226674344], "unit": "score", "name": "yui.html", "value": 5749.5161881063705}], "name": "dromaeo_css", "value": 6198.6917483825255}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 116.0, 110.0, 116.0, 116.0, 116.0, 105.0, 114.0, 117.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [173.0, 132.0, 162.0, 179.0, 136.0, 155.0, 165.0, 136.0, 169.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 154.3}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 170.0, 162.0, 164.0, 163.0, 163.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 106.0, 103.0, 74.0, 73.0, 73.0, 122.0, 107.0, 75.0], "unit": "score", "name": "audio-fft", "value": 88.2}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 130.0, 97.0, 97.0, 98.0, 139.0, 97.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 68.0, 65.0, 67.0, 66.0, 76.0, 70.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 67.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 71.0, 72.0, 72.0, 71.0, 70.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 89.0, 85.0, 87.0, 85.0, 85.0, 86.0, 90.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 127.0, 125.0, 126.0, 120.0, 122.0, 123.0, 125.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [165.0, 137.0, 150.0, 148.0, 148.0, 137.0, 151.0, 149.0, 146.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 75.0, 80.0, 71.0, 70.0, 70.0, 70.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1556.0}]} 02:38:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1556.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6198.69"}}} 02:38:12 INFO - Return code: 0 02:38:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:38:12 INFO - # TBPL SUCCESS # 02:38:12 INFO - Running post-action listener: _resource_record_post_action 02:38:12 INFO - Running post-run listener: _resource_record_post_run 02:38:13 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 533770240; Read time: 0; Write time: 969140 02:38:13 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 241967104; Read time: 0; Write time: 481948 02:38:13 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 291205120; Read time: 0; Write time: 486928 02:38:13 INFO - Running post-run listener: _upload_blobber_files 02:38:13 INFO - Blob upload gear active. 02:38:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:38:13 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 02:38:13 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'] 02:38:13 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 02:38:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:15 INFO - (blobuploader) - INFO - Done attempting. 02:38:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:38:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:38:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:38:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:38:15 INFO - (blobuploader) - INFO - Done attempting. 02:38:15 INFO - (blobuploader) - INFO - Iteration through files over. 02:38:15 INFO - Return code: 0 02:38:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:38:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:38:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68aaa49de7965decc3c5ec0f06ca9e41606173d9223db494d3d36bfb54866420e2b39dc3bfdc49f64adb27517b911812e580c3a4a19a0c1f3801abc4f5eace67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95ac674608d20fcb137bdcc4a159aa2e39c28dd65abd1ce23b6a7369fea848147ac445e6fd3277bc1b1c339e7710e44615fad844206866ed5e01f9622d21111d"} 02:38:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:38:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:38:15 INFO - Contents: 02:38:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68aaa49de7965decc3c5ec0f06ca9e41606173d9223db494d3d36bfb54866420e2b39dc3bfdc49f64adb27517b911812e580c3a4a19a0c1f3801abc4f5eace67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95ac674608d20fcb137bdcc4a159aa2e39c28dd65abd1ce23b6a7369fea848147ac445e6fd3277bc1b1c339e7710e44615fad844206866ed5e01f9622d21111d"} 02:38:15 INFO - Running post-run listener: copy_logs_to_upload_dir 02:38:15 INFO - Copying logs to upload dir... 02:38:15 INFO - mkdir: /builds/slave/test/build/upload/logs 02:38:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.017500 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-25 02:38:14.675209) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 02:38:14.679043) ========= 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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 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/68aaa49de7965decc3c5ec0f06ca9e41606173d9223db494d3d36bfb54866420e2b39dc3bfdc49f64adb27517b911812e580c3a4a19a0c1f3801abc4f5eace67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95ac674608d20fcb137bdcc4a159aa2e39c28dd65abd1ce23b6a7369fea848147ac445e6fd3277bc1b1c339e7710e44615fad844206866ed5e01f9622d21111d"} build_url:https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/KppCEbhkR9molJJutNK4jA/artifacts/public/build/firefox-47.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/68aaa49de7965decc3c5ec0f06ca9e41606173d9223db494d3d36bfb54866420e2b39dc3bfdc49f64adb27517b911812e580c3a4a19a0c1f3801abc4f5eace67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/95ac674608d20fcb137bdcc4a159aa2e39c28dd65abd1ce23b6a7369fea848147ac445e6fd3277bc1b1c339e7710e44615fad844206866ed5e01f9622d21111d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 02:38:14.703114) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:38:14.703412) ========= 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=1861a34ebfea852630dec091000001fa-1456395349.287862-1358857050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:38:14.788411) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 02:38:14.788731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 02:38:14.789029) ========= ========= Total master_lag: 0.26 =========