builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1459858060.98 results: success (0) buildid: 20160404030430 builduid: 46bb880f27d84b8ab0aeb165c3db5d03 revision: 784b84d126d848ef43e8495f52279b994c0d3e0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:40.981636) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:40.982139) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:40.982468) ========= 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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004911 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.000760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.001092) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.011981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.012318) ========= 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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004027 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.062886) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.063544) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.063953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.064263) ========= 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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 05:07:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-04-05 05:07:41 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.214581 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.292575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.292951) ========= 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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020959 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.346044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.346443) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 784b84d126d848ef43e8495f52279b994c0d3e0d --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 784b84d126d848ef43e8495f52279b994c0d3e0d --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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 05:07:41,552 truncating revision to first 12 chars 2016-04-05 05:07:41,552 Setting DEBUG logging. 2016-04-05 05:07:41,552 attempt 1/10 2016-04-05 05:07:41,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/784b84d126d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 05:07:41,889 unpacking tar archive at: fx-team-784b84d126d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601914 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.961784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:41.962168) ========= echo 784b84d126d848ef43e8495f52279b994c0d3e0d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'784b84d126d848ef43e8495f52279b994c0d3e0d'] 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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 784b84d126d848ef43e8495f52279b994c0d3e0d program finished with exit code 0 elapsedTime=0.004698 script_repo_revision: '784b84d126d848ef43e8495f52279b994c0d3e0d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:42.014023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:42.014390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 05:07:42.025356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-05 05:07:42.025724) ========= /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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:42 INFO - MultiFileLogger online at 20160405 05:07:42 in /builds/slave/test 05:07:42 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 05:07:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:42 INFO - {'append_to_log': False, 05:07:42 INFO - 'base_work_dir': '/builds/slave/test', 05:07:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:07:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:42 INFO - 'branch': 'Fx-Team-Non-PGO', 05:07:42 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:42 INFO - 'config_files': ('talos/linux_config.py',), 05:07:42 INFO - 'default_actions': ('clobber', 05:07:42 INFO - 'read-buildbot-config', 05:07:42 INFO - 'download-and-extract', 05:07:42 INFO - 'populate-webroot', 05:07:42 INFO - 'create-virtualenv', 05:07:42 INFO - 'install', 05:07:42 INFO - 'run-tests'), 05:07:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:42 INFO - 'download_minidump_stackwalk': True, 05:07:42 INFO - 'download_symbols': 'ondemand', 05:07:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:42 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:42 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:42 INFO - 'installer_path': 'installer.exe', 05:07:42 INFO - 'log_level': 'info', 05:07:42 INFO - 'log_name': 'talos', 05:07:42 INFO - 'log_to_console': True, 05:07:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:42 INFO - 'opt_config_files': (), 05:07:42 INFO - 'pip_index': False, 05:07:42 INFO - 'sps_profile': False, 05:07:42 INFO - 'sps_profile_interval': 0, 05:07:42 INFO - 'suite': 'dromaeojs', 05:07:42 INFO - 'system_bits': '32', 05:07:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:42 INFO - 'title': 'talos-linux64-ix-044', 05:07:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:42 INFO - 'use_talos_json': True, 05:07:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:42 INFO - 'work_dir': 'build'} 05:07:42 INFO - ##### 05:07:42 INFO - ##### Running clobber step. 05:07:42 INFO - ##### 05:07:42 INFO - Running pre-action listener: _resource_record_pre_action 05:07:42 INFO - Running main action method: clobber 05:07:42 INFO - rmtree: /builds/slave/test/build 05:07:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:42 INFO - Running post-action listener: _resource_record_post_action 05:07:42 INFO - ##### 05:07:42 INFO - ##### Running read-buildbot-config step. 05:07:42 INFO - ##### 05:07:42 INFO - Running pre-action listener: _resource_record_pre_action 05:07:42 INFO - Running main action method: read_buildbot_config 05:07:42 INFO - Using buildbot properties: 05:07:42 INFO - { 05:07:42 INFO - "project": "", 05:07:42 INFO - "product": "firefox", 05:07:42 INFO - "script_repo_revision": "production", 05:07:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:07:42 INFO - "repository": "", 05:07:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:07:42 INFO - "buildid": "20160404030430", 05:07:42 INFO - "pgo_build": "False", 05:07:42 INFO - "basedir": "/builds/slave/test", 05:07:42 INFO - "buildnumber": 2758, 05:07:42 INFO - "slavename": "talos-linux64-ix-044", 05:07:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:07:42 INFO - "platform": "ubuntu64_hw", 05:07:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:07:42 INFO - "branch": "fx-team", 05:07:42 INFO - "repo_path": "integration/fx-team", 05:07:42 INFO - "revision": "784b84d126d848ef43e8495f52279b994c0d3e0d", 05:07:42 INFO - "stage_platform": "linux64", 05:07:42 INFO - "builduid": "46bb880f27d84b8ab0aeb165c3db5d03", 05:07:42 INFO - "slavebuilddir": "test" 05:07:42 INFO - } 05:07:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:07:42 INFO - Running post-action listener: _resource_record_post_action 05:07:42 INFO - ##### 05:07:42 INFO - ##### Running download-and-extract step. 05:07:42 INFO - ##### 05:07:42 INFO - Running pre-action listener: _resource_record_pre_action 05:07:42 INFO - Running main action method: download_and_extract 05:07:42 INFO - mkdir: /builds/slave/test/build/tests 05:07: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')]} 05:07:42 INFO - https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:07:43 INFO - Downloaded 1361 bytes. 05:07:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:07:43 INFO - Using the following test package requirements: 05:07:43 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:43 INFO - u'jsshell-linux-x86_64.zip'], 05:07:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:43 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:43 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07:43 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')]} 05:07:43 INFO - https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:44 INFO - Downloaded 22125225 bytes. 05:07:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:46 INFO - Return code: 0 05:07:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:07: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')]} 05:07:46 INFO - https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:07:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:07:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:47 INFO - Downloaded 22125225 bytes. 05:07:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:07:48 INFO - Return code: 0 05:07: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')]} 05:07:48 INFO - https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:07:50 INFO - Downloaded 10847584 bytes. 05:07:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:07:50 INFO - Return code: 0 05:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:50 INFO - https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:07:52 INFO - Downloaded 54089524 bytes. 05:07:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:52 INFO - mkdir: /builds/slave/test/properties 05:07:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:52 INFO - Contents: 05:07:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:07:52 INFO - Running post-action listener: _resource_record_post_action 05:07:52 INFO - Running post-action listener: set_extra_try_arguments 05:07:52 INFO - ##### 05:07:52 INFO - ##### Running populate-webroot step. 05:07:52 INFO - ##### 05:07:52 INFO - Running pre-action listener: _resource_record_pre_action 05:07:52 INFO - Running main action method: populate_webroot 05:07:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:52 INFO - '--tppagecycles', 05:07:52 INFO - '7'], 05:07:52 INFO - 'tests': ['tsvgm']}}, 05:07:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:07:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:07:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:52 INFO - 'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:52 INFO - 'tests': ['damp', 'tps']}, 05:07:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:52 INFO - 'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['damp', 'tps']}, 05:07:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:07:52 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['dromaeo_dom']}, 05:07:52 INFO - 'other': {'tests': ['a11yr', 05:07:52 INFO - 'ts_paint', 05:07:52 INFO - 'tpaint', 05:07:52 INFO - 'sessionrestore', 05:07:52 INFO - 'sessionrestore_no_auto_restore', 05:07:52 INFO - 'tabpaint']}, 05:07:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['a11yr', 05:07:52 INFO - 'ts_paint', 05:07:52 INFO - 'tpaint', 05:07:52 INFO - 'sessionrestore', 05:07:52 INFO - 'sessionrestore_no_auto_restore', 05:07:52 INFO - 'tabpaint']}, 05:07:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['a11yr', 05:07:52 INFO - 'ts_paint', 05:07:52 INFO - 'tpaint', 05:07:52 INFO - 'sessionrestore', 05:07:52 INFO - 'sessionrestore_no_auto_restore', 05:07:52 INFO - 'tabpaint']}, 05:07:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['a11yr', 05:07:52 INFO - 'ts_paint', 05:07:52 INFO - 'tpaint', 05:07:52 INFO - 'sessionrestore', 05:07:52 INFO - 'sessionrestore_no_auto_restore', 05:07:52 INFO - 'tabpaint']}, 05:07:52 INFO - 'other_l64': {'tests': ['a11yr', 05:07:52 INFO - 'ts_paint', 05:07:52 INFO - 'tpaint', 05:07:52 INFO - 'sessionrestore', 05:07:52 INFO - 'sessionrestore_no_auto_restore', 05:07:52 INFO - 'tabpaint']}, 05:07:52 INFO - 'other_nol64': {'tests': ['a11yr', 05:07:52 INFO - 'ts_paint', 05:07:52 INFO - 'tpaint', 05:07:52 INFO - 'sessionrestore', 05:07:52 INFO - 'sessionrestore_no_auto_restore', 05:07:52 INFO - 'tabpaint']}, 05:07:52 INFO - 'svgr': {'tests': ['tsvgx', 05:07:52 INFO - 'tsvgr_opacity', 05:07:52 INFO - 'tart', 05:07:52 INFO - 'tscrollx', 05:07:52 INFO - 'cart']}, 05:07:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['tsvgx', 05:07:52 INFO - 'tsvgr_opacity', 05:07:52 INFO - 'tart', 05:07:52 INFO - 'tscrollx', 05:07:52 INFO - 'cart']}, 05:07:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:52 INFO - 'tests': ['tp5o']}, 05:07:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:52 INFO - 'talos_options': ['--e10s'], 05:07:52 INFO - 'tests': ['tp5o']}, 05:07:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:52 INFO - 'talos_options': ['--xperf_path', 05:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:52 INFO - 'tests': ['tp5n']}, 05:07:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:52 INFO - 'talos_options': ['--e10s', 05:07:52 INFO - '--xperf_path', 05:07:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:52 INFO - 'tests': ['tp5n']}}, 05:07:52 INFO - 'talos.zip': {'path': '', 05:07:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:52 INFO - Running post-action listener: _resource_record_post_action 05:07:52 INFO - ##### 05:07:52 INFO - ##### Running create-virtualenv step. 05:07:52 INFO - ##### 05:07:52 INFO - Running pre-action listener: _resource_record_pre_action 05:07:52 INFO - Running main action method: create_virtualenv 05:07:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:52 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 05:07:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:52 INFO - Using real prefix '/usr' 05:07:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:55 INFO - Installing pip.................done. 05:07:55 INFO - Return code: 0 05:07:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:07: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', 'pip>=1.5'] in /builds/slave/test/build 05:07: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 pip>=1.5 05:07:55 INFO - Using env: {'DISPLAY': ':0', 05:07:55 INFO - 'HOME': '/home/cltbld', 05:07:55 INFO - 'LANG': 'en_US.UTF-8', 05:07:55 INFO - 'LANGUAGE': 'en_US:en', 05:07:55 INFO - 'LOGNAME': 'cltbld', 05:07:55 INFO - 'MAIL': '/var/mail/cltbld', 05:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:55 INFO - 'MOZ_NO_REMOTE': '1', 05:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:55 INFO - 'NO_EM_RESTART': '1', 05:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:55 INFO - 'PWD': '/builds/slave/test', 05:07:55 INFO - 'SHELL': '/bin/bash', 05:07:55 INFO - 'SHLVL': '1', 05:07:55 INFO - 'TERM': 'linux', 05:07:55 INFO - 'TMOUT': '86400', 05:07:55 INFO - 'USER': 'cltbld', 05:07:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:55 INFO - '_': '/tools/buildbot/bin/python'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 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 05:07:55 INFO - Cleaning up... 05:07:55 INFO - Return code: 0 05:07:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', '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 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:07: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:07: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 psutil>=0.7.1 05:07:55 INFO - Using env: {'DISPLAY': ':0', 05:07:55 INFO - 'HOME': '/home/cltbld', 05:07:55 INFO - 'LANG': 'en_US.UTF-8', 05:07:55 INFO - 'LANGUAGE': 'en_US:en', 05:07:55 INFO - 'LOGNAME': 'cltbld', 05:07:55 INFO - 'MAIL': '/var/mail/cltbld', 05:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:55 INFO - 'MOZ_NO_REMOTE': '1', 05:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:55 INFO - 'NO_EM_RESTART': '1', 05:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:55 INFO - 'PWD': '/builds/slave/test', 05:07:55 INFO - 'SHELL': '/bin/bash', 05:07:55 INFO - 'SHLVL': '1', 05:07:55 INFO - 'TERM': 'linux', 05:07:55 INFO - 'TMOUT': '86400', 05:07:55 INFO - 'USER': 'cltbld', 05:07:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:55 INFO - '_': '/tools/buildbot/bin/python'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 INFO - Downloading/unpacking psutil>=0.7.1 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:57 INFO - Installing collected packages: psutil 05:07:57 INFO - Running setup.py install for psutil 05:07:57 INFO - building 'psutil._psutil_linux' extension 05:07:57 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 05:07:58 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 05:07:58 INFO - building 'psutil._psutil_posix' extension 05:07:58 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 05:07:58 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 05:07:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:58 INFO - Successfully installed psutil 05:07:58 INFO - Cleaning up... 05:07:58 INFO - Return code: 0 05:07:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:07:58 INFO - Using env: {'DISPLAY': ':0', 05:07:58 INFO - 'HOME': '/home/cltbld', 05:07:58 INFO - 'LANG': 'en_US.UTF-8', 05:07:58 INFO - 'LANGUAGE': 'en_US:en', 05:07:58 INFO - 'LOGNAME': 'cltbld', 05:07:58 INFO - 'MAIL': '/var/mail/cltbld', 05:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:58 INFO - 'MOZ_NO_REMOTE': '1', 05:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:58 INFO - 'NO_EM_RESTART': '1', 05:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:58 INFO - 'PWD': '/builds/slave/test', 05:07:58 INFO - 'SHELL': '/bin/bash', 05:07:58 INFO - 'SHLVL': '1', 05:07:58 INFO - 'TERM': 'linux', 05:07:58 INFO - 'TMOUT': '86400', 05:07:58 INFO - 'USER': 'cltbld', 05:07:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:58 INFO - '_': '/tools/buildbot/bin/python'} 05:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:08:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:00 INFO - Installing collected packages: mozsystemmonitor 05:08:00 INFO - Running setup.py install for mozsystemmonitor 05:08:00 INFO - Successfully installed mozsystemmonitor 05:08:00 INFO - Cleaning up... 05:08:00 INFO - Return code: 0 05:08:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:08:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:08:00 INFO - Using env: {'DISPLAY': ':0', 05:08:00 INFO - 'HOME': '/home/cltbld', 05:08:00 INFO - 'LANG': 'en_US.UTF-8', 05:08:00 INFO - 'LANGUAGE': 'en_US:en', 05:08:00 INFO - 'LOGNAME': 'cltbld', 05:08:00 INFO - 'MAIL': '/var/mail/cltbld', 05:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:00 INFO - 'MOZ_NO_REMOTE': '1', 05:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:00 INFO - 'NO_EM_RESTART': '1', 05:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:00 INFO - 'PWD': '/builds/slave/test', 05:08:00 INFO - 'SHELL': '/bin/bash', 05:08:00 INFO - 'SHLVL': '1', 05:08:00 INFO - 'TERM': 'linux', 05:08:00 INFO - 'TMOUT': '86400', 05:08:00 INFO - 'USER': 'cltbld', 05:08:00 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:00 INFO - '_': '/tools/buildbot/bin/python'} 05:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:03 INFO - Downloading docopt-0.6.1.tar.gz 05:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:03 INFO - Running setup.py install for blobuploader 05:08:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:03 INFO - Running setup.py install for requests 05:08:03 INFO - Running setup.py install for docopt 05:08:04 INFO - Successfully installed blobuploader requests docopt 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 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 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:08:04 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 05:08:04 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 05:08:04 INFO - Using env: {'DISPLAY': ':0', 05:08:04 INFO - 'HOME': '/home/cltbld', 05:08:04 INFO - 'LANG': 'en_US.UTF-8', 05:08:04 INFO - 'LANGUAGE': 'en_US:en', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MAIL': '/var/mail/cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SHLVL': '1', 05:08:04 INFO - 'TERM': 'linux', 05:08:04 INFO - 'TMOUT': '86400', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - '_': '/tools/buildbot/bin/python'} 05:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:04 INFO - Running setup.py (path:/tmp/pip-kZu40G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:04 INFO - Running setup.py (path:/tmp/pip-yahWHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:04 INFO - Running setup.py (path:/tmp/pip-z1e7rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:04 INFO - Running setup.py (path:/tmp/pip-QsDqLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:04 INFO - Running setup.py (path:/tmp/pip-ZKVRT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:04 INFO - Running setup.py (path:/tmp/pip-jw3D1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:04 INFO - Running setup.py (path:/tmp/pip-apKMAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:04 INFO - Running setup.py (path:/tmp/pip-dZcRqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:04 INFO - Running setup.py (path:/tmp/pip-YOcgNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:05 INFO - Running setup.py (path:/tmp/pip-9KA03F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:05 INFO - Running setup.py (path:/tmp/pip-bicj0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:05 INFO - Running setup.py (path:/tmp/pip-jR7kAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:05 INFO - Running setup.py (path:/tmp/pip-Ly9wto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:05 INFO - Running setup.py (path:/tmp/pip-sdRt23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:05 INFO - Running setup.py (path:/tmp/pip-trI21K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:05 INFO - Running setup.py (path:/tmp/pip-_sHYsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:05 INFO - Running setup.py (path:/tmp/pip-SA9FKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:05 INFO - Running setup.py install for manifestparser 05:08:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozcrash 05:08:05 INFO - Running setup.py install for mozdebug 05:08:05 INFO - Running setup.py install for mozdevice 05:08:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:05 INFO - Running setup.py install for mozfile 05:08:06 INFO - Running setup.py install for mozhttpd 05:08:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozinfo 05:08:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozInstall 05:08:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozleak 05:08:06 INFO - Running setup.py install for mozlog 05:08:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for moznetwork 05:08:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozprocess 05:08:06 INFO - Running setup.py install for mozprofile 05:08:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:06 INFO - Running setup.py install for mozrunner 05:08:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:07 INFO - Running setup.py install for mozscreenshot 05:08:07 INFO - Running setup.py install for moztest 05:08:07 INFO - Running setup.py install for mozversion 05:08:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:07 INFO - Cleaning up... 05:08:07 INFO - Return code: 0 05:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:07 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')]} 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 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')]} 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 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 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:08:07 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 05:08:07 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 05:08:07 INFO - Using env: {'DISPLAY': ':0', 05:08:07 INFO - 'HOME': '/home/cltbld', 05:08:07 INFO - 'LANG': 'en_US.UTF-8', 05:08:07 INFO - 'LANGUAGE': 'en_US:en', 05:08:07 INFO - 'LOGNAME': 'cltbld', 05:08:07 INFO - 'MAIL': '/var/mail/cltbld', 05:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:07 INFO - 'MOZ_NO_REMOTE': '1', 05:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:07 INFO - 'NO_EM_RESTART': '1', 05:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:07 INFO - 'PWD': '/builds/slave/test', 05:08:07 INFO - 'SHELL': '/bin/bash', 05:08:07 INFO - 'SHLVL': '1', 05:08:07 INFO - 'TERM': 'linux', 05:08:07 INFO - 'TMOUT': '86400', 05:08:07 INFO - 'USER': 'cltbld', 05:08:07 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:07 INFO - '_': '/tools/buildbot/bin/python'} 05:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:07 INFO - Running setup.py (path:/tmp/pip-3TnkGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:07 INFO - Running setup.py (path:/tmp/pip-XQ0JL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:07 INFO - Running setup.py (path:/tmp/pip-UIqc47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:07 INFO - Running setup.py (path:/tmp/pip-FOSC77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:07 INFO - Running setup.py (path:/tmp/pip-tKOOKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:07 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)) 05:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:07 INFO - Running setup.py (path:/tmp/pip-iI9Mvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:08 INFO - Running setup.py (path:/tmp/pip-wwkHwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:08 INFO - Running setup.py (path:/tmp/pip-ofQlJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:08 INFO - Running setup.py (path:/tmp/pip-2xfTsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:08 INFO - Running setup.py (path:/tmp/pip-oNJ7oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:08 INFO - Running setup.py (path:/tmp/pip-F_7wbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:08 INFO - Running setup.py (path:/tmp/pip-YHjy3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:08 INFO - Running setup.py (path:/tmp/pip-bNpXH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:08 INFO - Running setup.py (path:/tmp/pip-fA_o1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:08 INFO - Running setup.py (path:/tmp/pip-KbPIOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:08 INFO - Running setup.py (path:/tmp/pip-bgyMFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:08 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)) 05:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:08 INFO - Running setup.py (path:/tmp/pip-0axKWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:08 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)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:08 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)) 05:08:08 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)) 05:08:08 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)) 05:08:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:10 INFO - Downloading blessings-1.6.tar.gz 05:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:10 INFO - Installing collected packages: blessings 05:08:10 INFO - Running setup.py install for blessings 05:08:11 INFO - Successfully installed blessings 05:08:11 INFO - Cleaning up... 05:08:11 INFO - Return code: 0 05:08:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:11 INFO - Reading from file tmpfile_stdout 05:08:11 INFO - Current package versions: 05:08:11 INFO - argparse == 1.2.1 05:08:11 INFO - blessings == 1.6 05:08:11 INFO - blobuploader == 1.2.4 05:08:11 INFO - docopt == 0.6.1 05:08:11 INFO - manifestparser == 1.1 05:08:11 INFO - mozInstall == 1.12 05:08:11 INFO - mozcrash == 0.17 05:08:11 INFO - mozdebug == 0.1 05:08:11 INFO - mozdevice == 0.48 05:08:11 INFO - mozfile == 1.2 05:08:11 INFO - mozhttpd == 0.7 05:08:11 INFO - mozinfo == 0.9 05:08:11 INFO - mozleak == 0.1 05:08:11 INFO - mozlog == 3.1 05:08:11 INFO - moznetwork == 0.27 05:08:11 INFO - mozprocess == 0.22 05:08:11 INFO - mozprofile == 0.28 05:08:11 INFO - mozrunner == 6.11 05:08:11 INFO - mozscreenshot == 0.1 05:08:11 INFO - mozsystemmonitor == 0.0 05:08:11 INFO - moztest == 0.7 05:08:11 INFO - mozversion == 1.4 05:08:11 INFO - psutil == 3.1.1 05:08:11 INFO - requests == 1.2.3 05:08:11 INFO - wsgiref == 0.1.2 05:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 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 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:08:11 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 05:08:11 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 05:08:11 INFO - Using env: {'DISPLAY': ':0', 05:08:11 INFO - 'HOME': '/home/cltbld', 05:08:11 INFO - 'LANG': 'en_US.UTF-8', 05:08:11 INFO - 'LANGUAGE': 'en_US:en', 05:08:11 INFO - 'LOGNAME': 'cltbld', 05:08:11 INFO - 'MAIL': '/var/mail/cltbld', 05:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:11 INFO - 'MOZ_NO_REMOTE': '1', 05:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:11 INFO - 'NO_EM_RESTART': '1', 05:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:11 INFO - 'PWD': '/builds/slave/test', 05:08:11 INFO - 'SHELL': '/bin/bash', 05:08:11 INFO - 'SHLVL': '1', 05:08:11 INFO - 'TERM': 'linux', 05:08:11 INFO - 'TMOUT': '86400', 05:08:11 INFO - 'USER': 'cltbld', 05:08:11 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:11 INFO - '_': '/tools/buildbot/bin/python'} 05:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 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)) 05:08:11 INFO - Cleaning up... 05:08:11 INFO - Return code: 0 05:08:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:08: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', 'jsonschema'] in /builds/slave/test/build 05:08: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 jsonschema 05:08:11 INFO - Using env: {'DISPLAY': ':0', 05:08:11 INFO - 'HOME': '/home/cltbld', 05:08:11 INFO - 'LANG': 'en_US.UTF-8', 05:08:11 INFO - 'LANGUAGE': 'en_US:en', 05:08:11 INFO - 'LOGNAME': 'cltbld', 05:08:11 INFO - 'MAIL': '/var/mail/cltbld', 05:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:11 INFO - 'MOZ_NO_REMOTE': '1', 05:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:11 INFO - 'NO_EM_RESTART': '1', 05:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:11 INFO - 'PWD': '/builds/slave/test', 05:08:11 INFO - 'SHELL': '/bin/bash', 05:08:11 INFO - 'SHLVL': '1', 05:08:11 INFO - 'TERM': 'linux', 05:08:11 INFO - 'TMOUT': '86400', 05:08:11 INFO - 'USER': 'cltbld', 05:08:11 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:11 INFO - '_': '/tools/buildbot/bin/python'} 05:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:11 INFO - Downloading/unpacking jsonschema 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:13 INFO - warning: no files found matching '*.txt' 05:08:13 INFO - no previously-included directories found matching 'build' 05:08:13 INFO - no previously-included directories found matching 'dist' 05:08:13 INFO - no previously-included directories found matching '.git*' 05:08:13 INFO - Installing collected packages: jsonschema, functools32 05:08:13 INFO - Running setup.py install for functools32 05:08:14 INFO - warning: no files found matching '*.txt' 05:08:14 INFO - no previously-included directories found matching 'build' 05:08:14 INFO - no previously-included directories found matching 'dist' 05:08:14 INFO - no previously-included directories found matching '.git*' 05:08:14 INFO - Successfully installed jsonschema functools32 05:08:14 INFO - Cleaning up... 05:08:14 INFO - Return code: 0 05:08:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:14 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')]} 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:14 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')]} 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:14 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 0x7f5ea7df8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, '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': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', '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 05:08:14 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 05:08:14 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 05:08:14 INFO - Using env: {'DISPLAY': ':0', 05:08:14 INFO - 'HOME': '/home/cltbld', 05:08:14 INFO - 'LANG': 'en_US.UTF-8', 05:08:14 INFO - 'LANGUAGE': 'en_US:en', 05:08:14 INFO - 'LOGNAME': 'cltbld', 05:08:14 INFO - 'MAIL': '/var/mail/cltbld', 05:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:14 INFO - 'MOZ_NO_REMOTE': '1', 05:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:14 INFO - 'NO_EM_RESTART': '1', 05:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:14 INFO - 'PWD': '/builds/slave/test', 05:08:14 INFO - 'SHELL': '/bin/bash', 05:08:14 INFO - 'SHLVL': '1', 05:08:14 INFO - 'TERM': 'linux', 05:08:14 INFO - 'TMOUT': '86400', 05:08:14 INFO - 'USER': 'cltbld', 05:08:14 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:14 INFO - '_': '/tools/buildbot/bin/python'} 05:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:14 INFO - Downloading/unpacking flake8 05:08:14 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 05:08:14 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 05:08:14 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 05:08:14 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 05:08:14 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 05:08:14 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 05:08:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 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 05:08:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:16 INFO - no previously-included directories found matching 'docs/_build' 05:08:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:16 INFO - Running setup.py install for pep8 05:08:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:17 INFO - no previously-included directories found matching 'docs/_build' 05:08:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:17 INFO - Cleaning up... 05:08:17 INFO - Return code: 0 05:08:17 INFO - Running post-action listener: _resource_record_post_action 05:08:17 INFO - Running post-action listener: _start_resource_monitoring 05:08:17 INFO - Starting resource monitoring. 05:08:17 INFO - ##### 05:08:17 INFO - ##### Running install step. 05:08:17 INFO - ##### 05:08:17 INFO - Running pre-action listener: _resource_record_pre_action 05:08:17 INFO - Running main action method: install 05:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:17 INFO - Reading from file tmpfile_stdout 05:08:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:17 INFO - Reading from file tmpfile_stdout 05:08:17 INFO - Output received: 05:08:17 INFO - Usage: mozinstall [options] installer 05:08:17 INFO - Options: 05:08:17 INFO - -h, --help show this help message and exit 05:08:17 INFO - -d DEST, --destination=DEST 05:08:17 INFO - Directory to install application into. [default: 05:08:17 INFO - "/builds/slave/test"] 05:08:17 INFO - --app=APP Application being installed. [default: firefox] 05:08:17 INFO - mkdir: /builds/slave/test/build/application 05:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:08:33 INFO - Reading from file tmpfile_stdout 05:08:33 INFO - Output received: 05:08:33 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:33 INFO - Running post-action listener: _resource_record_post_action 05:08:33 INFO - ##### 05:08:33 INFO - ##### Running run-tests step. 05:08:33 INFO - ##### 05:08:33 INFO - Running pre-action listener: _resource_record_pre_action 05:08:33 INFO - Running main action method: run_tests 05:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:33 INFO - Python 2.7.3 05:08:33 INFO - Return code: 0 05:08:33 INFO - grabbing minidump binary from tooltool 05:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:33 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 0x1355410>, '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 0x1356310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13567a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:33 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 05:08:33 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 05:08:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:33 INFO - Return code: 0 05:08:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:08:34 INFO - Return code: 0 05:08:34 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/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:08:34 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/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 05:08:34 INFO - Using env: {'DISPLAY': ':0', 05:08:34 INFO - 'HOME': '/home/cltbld', 05:08:34 INFO - 'LANG': 'en_US.UTF-8', 05:08:34 INFO - 'LANGUAGE': 'en_US:en', 05:08:34 INFO - 'LOGNAME': 'cltbld', 05:08:34 INFO - 'MAIL': '/var/mail/cltbld', 05:08:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:34 INFO - 'MOZ_NO_REMOTE': '1', 05:08:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:34 INFO - 'NO_EM_RESTART': '1', 05:08:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:34 INFO - 'PWD': '/builds/slave/test', 05:08:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:34 INFO - 'SHELL': '/bin/bash', 05:08:34 INFO - 'SHLVL': '1', 05:08:34 INFO - 'TERM': 'linux', 05:08:34 INFO - 'TMOUT': '86400', 05:08:34 INFO - 'USER': 'cltbld', 05:08:34 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811', 05:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:34 INFO - '_': '/tools/buildbot/bin/python'} 05:08:34 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/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 05:08:34 INFO - mozversion application_buildid: 20160404030430 05:08:34 INFO - mozversion application_changeset: 784b84d126d848ef43e8495f52279b994c0d3e0d 05:08:34 INFO - mozversion application_display_name: Nightly 05:08:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:34 INFO - mozversion application_name: Firefox 05:08:34 INFO - mozversion application_remotingname: firefox 05:08:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:34 INFO - mozversion application_vendor: Mozilla 05:08:34 INFO - mozversion application_version: 48.0a1 05:08:34 INFO - mozversion platform_buildid: 20160404030430 05:08:34 INFO - mozversion platform_changeset: 784b84d126d848ef43e8495f52279b994c0d3e0d 05:08:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:34 INFO - mozversion platform_version: 48.0a1 05:08:34 INFO - using testdate: 1459858114 05:08:34 INFO - actual date: 1459858114 05:08:34 INFO - starting webserver on 'localhost:48819' 05:08:34 INFO - SUITE-START | Running 2 tests 05:08:34 INFO - TEST-START | dromaeo_css 05:08:34 INFO - operating with platform_type : linux_ 05:08:34 INFO - Initialising browser for dromaeo_css test... 05:08:34 INFO - TEST-INFO | started process 12935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU1D7nU/profile http://localhost:48819/getInfo.html) 05:08:39 INFO - PROCESS | 12935 | __metrics Screen width/height:1600/1200 05:08:39 INFO - PROCESS | 12935 | colorDepth:24 05:08:39 INFO - PROCESS | 12935 | Browser inner width/height: 1024/697 05:08:39 INFO - PROCESS | 12935 | __metrics 05:08:40 ERROR - PROCESS | 12935 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:08:40 INFO - TEST-INFO | 12935: exit 0 05:08:40 INFO - Browser initialized. 05:08:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:40 INFO - TEST-INFO | started process 13017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU1D7nU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:52 INFO - PROCESS | 13017 | RSS: Main: 155054080 05:08:52 INFO - PROCESS | 13017 | 05:09:43 INFO - PROCESS | 13017 | 1459858183798 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] 05:11:55 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48819/tests/dromaeo/cssquery-ext.html) 05:11:56 INFO - PROCESS | 13017 | RSS: Main: 225894400 05:11:56 INFO - PROCESS | 13017 | 05:14:58 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-ext.html (next: http://localhost:48819/tests/dromaeo/cssquery-jquery.html) 05:14:59 INFO - PROCESS | 13017 | RSS: Main: 244592640 05:14:59 INFO - PROCESS | 13017 | 05:18:01 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48819/tests/dromaeo/cssquery-mootools.html) 05:18:01 INFO - PROCESS | 13017 | RSS: Main: 244121600 05:18:01 INFO - PROCESS | 13017 | 05:21:03 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48819/tests/dromaeo/cssquery-prototype.html) 05:21:04 INFO - PROCESS | 13017 | RSS: Main: 221622272 05:21:04 INFO - PROCESS | 13017 | 05:24:07 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48819/tests/dromaeo/cssquery-yui.html) 05:24:07 INFO - PROCESS | 13017 | RSS: Main: 202215424 05:24:07 INFO - PROCESS | 13017 | 05:27:09 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-yui.html (next: http://localhost:48819/tests/dromaeo/cssquery-dojo.html) 05:27:10 INFO - PROCESS | 13017 | RSS: Main: 268984320 05:27:10 INFO - PROCESS | 13017 | 05:27:10 INFO - PROCESS | 13017 | __start_tp_report 05:27:10 INFO - PROCESS | 13017 | _x_x_mozilla_page_load 05:27:10 INFO - PROCESS | 13017 | _x_x_mozilla_page_load_details 05:27:10 INFO - PROCESS | 13017 | |i|pagename|runs| 05:27:10 INFO - PROCESS | 13017 | |0;dojo.html;2585.185666515048;2663.081236973245;2667.746564076413;2670.772984296335;2703.324168957761;4445.933311000337;4590.63274938005;4606.56237657422;4635.814567417299;4641.280601506767;4522.8643140705835;4562.429696287964;4587.495375508692;4609.585137337639;4668.696534725241;4185.958140418603;4206.179794939988;4215.831366745334;4301.935470967938;4383.298672212431;4056.290149223874;4273.542445129254;4312.568743125678;4325.048489332357;4325.697201195918;4165.208610364021;4210.32634778437;4211.220924129046;4238.788060596958;4259.105587826529;4254.234237837188;4254.468191476066;4265.466816647919;4283.678724095706;4300.956990430087;4138.296489596776;4234.55537168599;4242.384854196124;4242.660587153051;4287.935680964788;4464.8214071437105;4488.7531185784765;4508.932366014513;4516.029053753426;4558.407407037064;4891.828785992473;4916.0905232532095;4917.975410122926;4919.754012299407;4922.0402021605805;4763.380760501147;4910.705357678551;4929.852104436873;4994.026164897847;5021.020900924321;4563.452385713669;4621.838235661736;4622.907541849144;4625.537446255347;4626;5004.574611158092;5005.674631148963;5006.224035274538;5008.098542262428;5039.496050394931;4689.62483001359;4803.207470767354;4803.783829727601;4805.687630304019;4819.108464933998;4898.4121905371585;4901.803927842846;4918.262260660929;4942.159832828356;4948.579370753526;4846.975765121152;4855.393075865517;4857.149998750205;4864.270359446112;4896.926546101811;4656.883577910579;4770.904581908342;4814.9518504814505;4819.228923372244;4867.488913664085;4140.171965606891;4151;4176.519700234512;4205.600467955601;4206.242876282298;3601.9099522511624;3606.4770608261656;3646.726495512794;3648.1244501319493;3648.7810731356203;4119.773412462343;4161.2509748245;4167.770772607536;4190.476190476191;4194.2869712149;4931.334269873521;4933.654644174873;4934.851954441372;4948.653594248368;4992.90014199714;4219.767912764827;4236.279832428495;4247.10810729744;4248.34150706641;4289.206496798102;4411.448568928884;4445.177642136216;4499.392582001388;4516.638668906479;4541.9545804542195;4716.1510928033285;4717.174494463524;4717.504662010508;4726.905461890812;4745.644076694192;4928.827491037797;4937.407511098691;4938.259261110862;4942.4069111705385;4992.226204938241;4600.332951722048;4649.256119020941;4701.318308845267;4722.834700785456;4747.192977193954;4831.758412079312;4837.661363704507;4844.563989240844;4854.902901942012;4902.2156454967035;4906.092372911023;4923.4584195737725;4925.852224433273;4929.038837426668;4982.153033984304;4667.836625718083;4729.645276604338;4787.640926930564;4818.638602104786;4834.226523756182;4680.46174689915;4716.976415117902;4737.28940658904;4744.833930812405;4798.568128868418;4620.930686039645;4646.395968524071;4656.185167595725;4688.953110468988;4698.483166851712;4736.5973892219545;4745.359376484131;4813.831515897067;4830.95169048305;4922.1140194765285;4720.197566413649;4724.244120940633;4726.3146843708155;4729;4767.69010014348 05:27:10 INFO - PROCESS | 13017 | |1;ext.html;541.5153437673282;541.5369858770752;564.0918121823863;576.5906206593319;619.21050660408;29149.27126821828;29814.552781708266;29858.95493657725;37530.81234593823;38589.42115868264;41461;41946.7902660487;41981.740547783615;41992.79003604985;42003.36994945078;7778.338841198505;7955.562444065574;7962.283394494494;7964.247865469616;7965.561894095822;7676.731314403997;7809.258120478546;7811.648475818602;7811.843763124734;7815.218478152196;7796.649150788228;7859.70314898044;7867.7246296379635;7873.055233371975;7874.291313781759;7747.535147891116;7807.492512986694;7809.921900781004;7811.765647030598;7813;7874.212578742137;8010.719624813162;8015.95992020042;8018.919810801875;8022.638981245799;37355.25289494222;37703.81148094269;37805;37809;37812;2868.282929267683;2914.7085291470894;3112.7821052526333;3173.3335999439914;3221.01758963516;28431.857840710873;28443.715562844314;29091.56362654562;29138.562921555982;29898.40203195924;3447.4828775683595;3502.964970350289;3511.9648803511895;3541.1855273287288;3648.3068217038945;229313.56029659568;229314;229742;229828.85085574634;231757.9999999983;41979;54929.72535137379;55343.72328138333;55352.723236384365;55401.445985540435;41455;41663.375049374285;41663.7916810414;41679.58320416818;41742.1651566967;12827.679308017188;13140.474381024653;13148.145370551076;13150.868491315156;13158.934205328913;9905;10033.548490317808;10042.899571004342;10043.397396156108;10045.547950342252;14690.192039437934;14779;14870.70258594822;14874.256287185814;14995.775063374058;5670.432956704297;5716.399778023331;5737.672150152985;5843.1235314703135;5919;901.7520181949885;949.7768024514234;958.8417911044739;989.5771173966702;1053.2942928238099;26437;26791.330216744736;27412.314692132855;27465.45069098607;27518.449631007268;802.418246771098;988.268681175939;1042.3537406807827;1054.9736256593646;1131.5417256011328;13591.932040339932;13822.516211932534;13932.98323832883;14079.225642589756;14220.71558568823;281664;374166;379341;379596;380314;50665.746671267145;51303.230451543255;51647.225291620656;51650;51734.74132629313;1061.1192710050639;1170.9063274937985;1231.6612931443924;1254.4166962362544;1259.118616968126;26295.60556591691;28539;29115.126546203646;29280.70719292865;29307.41385172327;38366.232675346895;38980.41529377005;38999.415008774326;38999.41500877546;39028.6097139025;166665;167232;167384;167481;171892;26795.598066028637;30891.227719307197;31013.689863101983;31228.687713123487;31671.40764589168;34757;34960.650393495736;35632.10919727028;35871.64128358683;35972.28055438824;30247.848760756056;30303;30662.846685766428;31384.686153138176;32851;32260.19349516281;32658.346833063682;35918;36747.44878826873;37420.43869341908;32357.35285294234;32705.672943270263;32883.8355808229;32990;33099.83450082831;28674.856625716737;28892.85553572219;29099.563506546994;29164.854175728986;29191.7080829189;23474.647880281467;24637.630435543124;24650.753492464846;24799.876000619883;25047.373815654755 05:27:10 INFO - PROCESS | 13017 | |2;jquery.html;337.6522182152383;345.9310729844779;347.7166109620657;351.3991075261303;352.3833291739456;15032.774508382356;15385.07689538627;15986.200689965513;16020.519384418487;16109.83890161098;15290.46483373082;15423.460178893742;15585.532434026969;15974.361025558992;16003.679926401464;4497.14554234696;4627.051454451846;4638.327442520833;4638.373819534353;4648.023914977842;5093.388793344785;5322;5324.387695415019;5325.600579956499;5328.040952628526;5252.159654455288;5284.2866213061125;5288.894222115556;5293;5294.047071527124;5089.3638295213095;5291.788328466857;5297.046531624306;5300.416954135023;5303.416624171338;5073.2897394364445;5096;5097;5158.200478925773;5166.896662066738;12507;18558.536036599056;19704.40886773399;19747.308844190527;19755.506112347164;1843.373253093941;1914.9712754308557;1954.2671498188179;2187.0377034104945;2248.5615305015526;9038.638454461814;9069.909300906973;9190.310726695525;9190.310726695525;9203.493807840567;1686.5277722237793;1747.3884140550833;1752.1326943163087;1854.7125195594704;1857.6934805757035;54137.45862541364;56065;58782.11826822601;59068;61499.6925015372;9622.566984485715;9653.372530785617;9654.379607647132;9707.757306067404;9715.222782177409;13009.609711708665;13102.80345794814;13131.212127272394;13134.408951597201;13156.736865262641;6947.930520694829;6970.51206415546;7061.646917654097;7177.1746249182015;7181.3177748114895;6781.287964763727;6967.268436814163;7027.964860175666;7052.929470705228;7096.964515177391;4218.978905105516;4222.852200172979;4224.429701990253;4308.913821723548;4309.095090031066;1751.9562010949574;1755;1785.526835388623;1800.0549711401356;1807.1235450806348;815.7308088330836;865.787881968909;914.7347269291964;934.0845970948372;936.3632729743704;15886.682266354608;16069.758953615705;16167.110808905623;16306.266218020217;16512;853.8591132463198;868.6308318964415;871.538084815049;906.5648488725317;908.2552307108108;9126.041765614647;9406.824146981628;9424.717258482257;9645.9035409645;9651.951740241253;366535;377081;378303;380537;387830;45905.58694663838;60700;67529.32470675328;70315;71056.28943710496;878.1920633017639;887.4773678430477;900.4597241655085;905.316486053039;924.3298608508777;14265.502122277012;14433.278336083364;14512.782308265596;14599.635009124857;14771.92614036966;30903.2274193147;31650;32493.18767030843;32587.511187331736;32836;47029;49125;49746;50034.249486258464;50378;7328.157261914948;7708.961455192688;7718.536887786526;7788.766337009899;7833.255840695125;11140.832887506533;11618.535258589562;11869.347185904859;11974.221675591407;12069.75860482803;6023.48800351975;8886.289096872106;9888.258380621339;10332.17342612574;10664.733381665521;10083.848742269018;10087.848682269918;10383.273170877967;10450.790984180427;10591.993760592732;10118.241131914989;10394.272400932165;10613.9469302653;10824.079953204066;10949.178811589321;7664.156942736183;7701.730439434593;7732.497387669783;7795.532268063935;7810.687572497037;9805.460699661588;10544.52549635253;10679.14566834667;10733.892661073602;10852.348859068165 05:27:10 INFO - PROCESS | 13017 | |3;mootools.html;1270.2251626507834;1381.7443772902013;1404.2978510744624;1517.2034681792065;1714.7856517935259;6473.902891456626;6928.203256625489;7092.85814283714;7100.360967512923;7101.325374089466;7016.052832867574;7179.820504487378;7181.210066892638;7182.066331376914;7184.640767961607;1861.5160058384781;1899.3921944977612;2135.508832968418;2152.62329092409;2160.8595441296266;2071.8860462674547;2088.5196404826897;2088.853780235384;2089.049482485473;2089.19565967103;2121.469632591852;2130.424785307966;2147.5275439403385;2214.2803588833694;2217.4678077261424;2135.4234356723596;2167.4147980045377;2179.7711240319695;2180.2805074325433;2202.064122747826;2165.177232651598;2193.7696541863033;2194.0455901682817;2197.2419515267366;2200.3508964855405;7303.488755787097;7396.408287337;7397.2602739726135;7402.925970740332;7403.629818509107;4327.956720432787;4443.977780111111;4446.110777844444;4452.1540907227845;4453.198424283628;2703.743144401298;2706.242252169376;2844.1609725131134;2850.1307101334087;2885.9855700721573;918.1552971266451;932.6129656192672;938.1041105743998;953.1183655119056;972.7373609125567;9389.061093890625;9402.294827887936;9409.905900940972;9440.858387124199;9454;3947.230290093404;3969.523657161159;4028.4762980812307;4045.5145382554283;4052.452918855917;8196.139405362352;8207.71273005442;8214.8357032859;8217.424780265444;8221.465604735673;4477.865664030084;4490.685652004394;4494;4496.303073023687;4497.280435130363;3456.7753096048677;4021.8391264349098;4091.284025295561;4098.610631989956;4127.5666055064385;3291.1607540077125;3369.983150084234;3391.236971681352;3401.863925443004;3422.5208470814105;1093.6281664234039;1098.9670309890716;1105.9612913548149;1107.3245320354577;1120.9831852522218;1146.8279758036194;1150.0339714639742;1157.2824848593925;1181.5569161564413;1222.9205101668363;6790.5925644461495;6818.215905170969;6819.897701534481;6844.726210951506;6846.246912839583;1010.3180353261666;1015.603914473356;1046.602291129366;1074.2587614546094;1074.3607553505651;5334.199870019528;5357.035733567917;5385.138377859524;5390.8921821563345;5396.1366181410785;8437.915620843713;8662.133786621413;8721.433106848035;8912.821743565093;9052.140046695553;8727.04002559718;8926.776830579287;8975.50634715097;8984.595693193822;8995;6663.966680166568;6684.465242780566;6772.627505487246;6782.287859774653;6827.385535301847;6575.80272591823;6626.4367528760595;6642.667866606747;6669.833254168685;6673.032410300576;7475.289847464483;7750.457467977188;7815.491993020435;7817;7824.569648669378;7780.610969451392;7923.603819809102;8044.597770111588;8047.919520804717;8177.918220817715;5483.835484935458;5566.666000039849;5576.024195765806;6119.265688117454;6211.2857021443115;5923.881522369615;6954.130733658293;6973.919042548413;6985.511014228955;6988.40598549129;6352.269489008823;6385.808425747235;6443.548951573345;6487.935120648733;6533.118029066015;6134.938650613437;6250.312465628868;6260.812175634738;6276.121343012073;6331.6517591531065;6514.2834288229205;6604.603723776589;6617.43751781104;6732.697028633625;6737.562058466184;6098.725557349841;6119.418655227746;6166.321704612399;6182.381761823782;6194.349593292639;5845.970770146122;5972.223610930551;6006.948783962702;6159.692015399122;6211.472024877936 05:27:10 INFO - PROCESS | 13017 | |4;prototype.html;306.8849181556916;307.6477433338827;308.51717062796723;308.78385130408714;311.3850145961726;5234.005538947602;5309.362876454826;5309.575233981287;5336.119540275859;5352.91970620441;5213.765380557875;5271.789128434868;5274.05067087925;5284.339457567795;5290.523852853243;3940.4089386592095;4022.4368588397647;4103.774292413916;4123.072308730541;4126.793660316987;4098.159877225176;4105.856295029675;4119.320312148507;4127.504699436072;4132.152908653718;3910.511186101737;4094.0379010932406;4094.2425651254466;4100.528439229482;4101.487314085739;3998.1403998140395;4051.6353528182312;4052.7770972596495;4070.653994410479;4072.735272207297;3565;3569.464580312948;3572.214112895159;3584.910377240564;3585.0678823505814;4997.600191984632;5015.0471410432265;5016.172331565287;5047.873803154914;5055.216441451544;4709.95290047102;4715.292706094114;4715.905681886377;4717.528247175289;4721.622270218374;5548.472895074961;5552.194931734916;5558.749856256478;5559.972200139014;5563.972180139114;3859.903502412434;3961.1681546875193;3961.3067713150085;3961.7424867383816;3973.3642617181113;5705.115707065412;5847.590668653196;5859.355470898197;5859.472647461749;5865.58940874139;4052.7163098583405;4083.7549747015273;4085.080856807254;4086.5504794472586;4087.7138600297694;4140.213359461693;4144.8134833932545;4148.502179738391;4150.584941505826;4150.979245103756;4704;4709.740964246999;4718.363020992122;4719.598834099072;4725.432948046257;5583.888322233533;5587.078132108238;5603.411641777555;5604.495595396434;5605.439456054362;1443.336065409923;1466.281522054207;1469.2580246975422;1470.3824393754649;1472.3006571878273;937.6530683647094;972.1785091597588;975.9072888075622;995.0894931137927;996.2378780233128;4780.832670856504;4816;4830.686005409637;4833.806647734122;4840.177169881129;5731.140328950691;5731.8853622928145;5737.627054241461;5739.598228124075;5743.741531631086;4834.226523756182;4837.564619184291;4840.370751802243;4841.588464980446;4842.031593681278;3042.9847850760602;3074.1546074829153;3076.3693442844165;3078.4920488119656;3082.4143412751505;5413.188021796762;5430.0768869292315;5437.184422336682;5439.129739241703;5442.564594832404;5759.222504961776;5992.460678538865;5994.880102397928;6003.429674180946;6005.759769609254;5466.72666366688;5498.945010549924;5523.475269849358;5534.861628459321;5544.63959842609;5826.504747096545;5836.533077353886;5841.824745257649;5849.912251316148;5852.707364631837;5707.971460142673;5713.314402271754;5718.885622287447;5722.284714410699;5724.3703192647945;5372.086745253238;5527.50252477279;5530.364008139116;5532.806351777668;5536.197251398444;3854.2484215577692;3942.6648734856713;3950.4666869973335;3950.762954222756;3954.525456945185;5745.3105627324985;5772.595918285848;5798.652080875161;5801.36185019639;5810.5061069809535;5571.749271282721;5582.218489411567;5583.553315734813;5590.161475778666;5595.07681232592;5581.218629391808;5588.86027849307;5596.076647353304;5598.272224610774;5599.80400685974;5358.115910874662;5511.5039646432015;5519.116941289374;5531.612787104864;5531.944680553143;5637.069883469346;5643.71781410936;5647.350554686263;5650.3219613646625;5652.7173641318595;5470.206820011155;5506.614536982533;5507.476789704971;5508.283923090133;5516.255305533862 05:27:10 INFO - PROCESS | 13017 | |5;yui.html;669.4142625202948;694.5138403117819;737.1412304665065;766.3562607409775;803.020315215437;12278.201916875409;12424.068194885374;12442.44009019594;12458.875411245896;12494.625161245154;11975.101867359961;12036.81944770829;12045.518179272818;12046.096542759284;12056.819147712791;630.3161070238785;788.4756636836497;807.9111297757242;811.0915774332726;817.3951276055735;803.4175222963363;808.7937575918132;814.5316443045273;818.5907046476761;818.7339114787688;663.6416335178998;865.5196366016858;865.5542395666206;869.2871845087031;869.7260362985671;841.7895526118471;849.3332733803934;852.9232369086812;853.2448782827181;853.8206976534904;620.2742790934617;623.5448122870284;623.9438450539428;624.9468795152418;626.3736263736264;11282.210245282833;11467.598634047768;11477.139214558942;11477.598284060101;11500.712482187928;11607.709807254801;11720.531178752839;11814.527418903233;12275.263484190888;12503.74992500154;10656.09423199029;10673.519691613896;10848.132149428027;10890.183236257313;10930.153723709996;3267.983660081708;3295.538624592559;3331.68349006844;3339.2152844081866;3392.9990652757497;42097;42545.149097017886;42624.36063459051;42707.14585708299;42717.14565708699;8920;9014.639414423349;9110.772230694152;9775.706728798148;9935.80128397428;16142.192890355434;16322.265498052617;16329.10189939541;16329.428470003493;16330.918345408198;6471.288158302583;6622.5695329804375;6663.433608143265;6724.798256052326;6758.324167583202;3568;3613.584437789688;3615.023943535231;3617.620149884277;3633.066254403821;2705.147878418292;2725.1552018874213;2726.1140129458004;2735.466584016098;2738.890444382242;414.97925103744694;512.3032675561234;522.8901930594542;531.4340227657532;533.226821109393;521.0906967342013;542.8317221661298;562.2072877243068;571.6941436331542;573.1402895656515;7335.339819416278;7630.7329243477325;7754.18581048993;7865.213478652204;7928.920710792819;494.6110287312273;515.3069122030862;570.8829689913558;573.8938296415176;574.4800955135609;3504.5268888700207;3584.8386822593047;3592.4252119660728;3614.7650402724266;3772.660460558508;49534.50465495299;50040.749796250784;50116.749416252685;50414.495855041714;50532.24201636978;43568.56431435645;46072;46084.308735369;46104.308435373496;46231.3065304014;40407.79796101001;40588.39117413241;41283.380749288786;41584.1683166335;41665.37501937473;7207.243239459991;7228.710851565878;7279.308465695751;7305.452091093083;7448.590327531821;31906;32097.35805283928;32213.35573288568;32764.34471310513;32837.83581082079;37485.25029499449;39031;39605.603943961345;39651.80174099226;39702.60297396989;8906.73279801607;8978.640854365753;9004.819903602021;9046.276297896284;9095.95452022762;9791.657291994747;9844.556994935389;9865.457399843077;9916.900830991597;10042.297039207186;8824.11758824138;8936.955315223382;9141.725748227564;10023.398596084258;10271.691849244535;10097.495125243855;10361.74095647615;10442.63450779219;10521.736956576147;10732.839007415052;9582.66460673873;9747.707568772948;9931.255155863195;10243.180545556188;10331.586736530455;8003.719869804529;8104.554249516097;8183;8246.793830154294;8295.294899933573;8053.758387248392;8250.257476827115;8302.128276530877;8427.662893484438;8432.156784321764 05:27:10 INFO - PROCESS | 13017 | __end_tp_report 05:27:10 INFO - PROCESS | 13017 | __start_cc_report 05:27:10 INFO - PROCESS | 13017 | _x_x_mozilla_cycle_collect,1050 05:27:10 INFO - PROCESS | 13017 | __end_cc_report 05:27:10 INFO - PROCESS | 13017 | __startTimestamp1459859230232__endTimestamp 05:27:10 INFO - PROCESS | 13017 | 05:27:10 INFO - PROCESS | 13017 | ------- Summary: start ------- 05:27:10 INFO - PROCESS | 13017 | Number of tests: 6 05:27:10 INFO - PROCESS | 13017 | 05:27:10 INFO - PROCESS | 13017 | [#0] dojo.html Cycles:165 Average:4542.37 Median:4680.46 stddev:461.21 (9.9%) stddev-sans-first:436.32 05:27:10 INFO - PROCESS | 13017 | Values: 2585.2 2663.1 2667.7 2670.8 2703.3 4445.9 4590.6 4606.6 4635.8 4641.3 4522.9 4562.4 4587.5 4609.6 4668.7 4186.0 4206.2 4215.8 4301.9 4383.3 4056.3 4273.5 4312.6 4325.0 4325.7 4165.2 4210.3 4211.2 4238.8 4259.1 4254.2 4254.5 4265.5 4283.7 4301.0 4138.3 4234.6 4242.4 4242.7 4287.9 4464.8 4488.8 4508.9 4516.0 4558.4 4891.8 4916.1 4918.0 4919.8 4922.0 4763.4 4910.7 4929.9 4994.0 5021.0 4563.5 4621.8 4622.9 4625.5 4626.0 5004.6 5005.7 5006.2 5008.1 5039.5 4689.6 4803.2 4803.8 4805.7 4819.1 4898.4 4901.8 4918.3 4942.2 4948.6 4847.0 4855.4 4857.1 4864.3 4896.9 4656.9 4770.9 4815.0 4819.2 4867.5 4140.2 4151.0 4176.5 4205.6 4206.2 3601.9 3606.5 3646.7 3648.1 3648.8 4119.8 4161.3 4167.8 4190.5 4194.3 4931.3 4933.7 4934.9 4948.7 4992.9 4219.8 4236.3 4247.1 4248.3 4289.2 4411.4 4445.2 4499.4 4516.6 4542.0 4716.2 4717.2 4717.5 4726.9 4745.6 4928.8 4937.4 4938.3 4942.4 4992.2 4600.3 4649.3 4701.3 4722.8 4747.2 4831.8 4837.7 4844.6 4854.9 4902.2 4906.1 4923.5 4925.9 4929.0 4982.2 4667.8 4729.6 4787.6 4818.6 4834.2 4680.5 4717.0 4737.3 4744.8 4798.6 4620.9 4646.4 4656.2 4689.0 4698.5 4736.6 4745.4 4813.8 4831.0 4922.1 4720.2 4724.2 4726.3 4729.0 4767.7 05:27:10 INFO - PROCESS | 13017 | 05:27:10 INFO - PROCESS | 13017 | [#1] ext.html Cycles:180 Average:40676.70 Median:34858.83 stddev:69976.09 (200.7%) stddev-sans-first:70107.50 05:27:10 INFO - PROCESS | 13017 | Values: 541.5 541.5 564.1 576.6 619.2 29149.3 29814.6 29859.0 37530.8 38589.4 41461.0 41946.8 41981.7 41992.8 42003.4 7778.3 7955.6 7962.3 7964.2 7965.6 7676.7 7809.3 7811.6 7811.8 7815.2 7796.6 7859.7 7867.7 7873.1 7874.3 7747.5 7807.5 7809.9 7811.8 7813.0 7874.2 8010.7 8016.0 8018.9 8022.6 37355.3 37703.8 37805.0 37809.0 37812.0 2868.3 2914.7 3112.8 3173.3 3221.0 28431.9 28443.7 29091.6 29138.6 29898.4 3447.5 3503.0 3512.0 3541.2 3648.3 229313.6 229314.0 229742.0 229828.9 231758.0 41979.0 54929.7 55343.7 55352.7 55401.4 41455.0 41663.4 41663.8 41679.6 41742.2 12827.7 13140.5 13148.1 13150.9 13158.9 9905.0 10033.5 10042.9 10043.4 10045.5 14690.2 14779.0 14870.7 14874.3 14995.8 5670.4 5716.4 5737.7 5843.1 5919.0 901.8 949.8 958.8 989.6 1053.3 26437.0 26791.3 27412.3 27465.5 27518.4 802.4 988.3 1042.4 1055.0 1131.5 13591.9 13822.5 13933.0 14079.2 14220.7 281664.0 374166.0 379341.0 379596.0 380314.0 50665.7 51303.2 51647.2 51650.0 51734.7 1061.1 1170.9 1231.7 1254.4 1259.1 26295.6 28539.0 29115.1 29280.7 29307.4 38366.2 38980.4 38999.4 38999.4 39028.6 166665.0 167232.0 167384.0 167481.0 171892.0 26795.6 30891.2 31013.7 31228.7 31671.4 34757.0 34960.7 35632.1 35871.6 35972.3 30247.8 30303.0 30662.8 31384.7 32851.0 32260.2 32658.3 35918.0 36747.4 37420.4 32357.4 32705.7 32883.8 32990.0 33099.8 28674.9 28892.9 29099.6 29164.9 29191.7 23474.6 24637.6 24650.8 24799.9 25047.4 05:27:10 INFO - PROCESS | 13017 | 05:27:10 INFO - PROCESS | 13017 | [#2] jquery.html Cycles:180 Average:22836.47 Median:4643.20 stddev:62032.31 (1336.0%) stddev-sans-first:62183.32 05:27:10 INFO - PROCESS | 13017 | Values: 337.7 345.9 347.7 351.4 352.4 15032.8 15385.1 15986.2 16020.5 16109.8 15290.5 15423.5 15585.5 15974.4 16003.7 4497.1 4627.1 4638.3 4638.4 4648.0 5093.4 5322.0 5324.4 5325.6 5328.0 5252.2 5284.3 5288.9 5293.0 5294.0 5089.4 5291.8 5297.0 5300.4 5303.4 5073.3 5096.0 5097.0 5158.2 5166.9 12507.0 18558.5 19704.4 19747.3 19755.5 1843.4 1915.0 1954.3 2187.0 2248.6 9038.6 9069.9 9190.3 9190.3 9203.5 1686.5 1747.4 1752.1 1854.7 1857.7 54137.5 56065.0 58782.1 59068.0 61499.7 9622.6 9653.4 9654.4 9707.8 9715.2 13009.6 13102.8 13131.2 13134.4 13156.7 6947.9 6970.5 7061.6 7177.2 7181.3 6781.3 6967.3 7028.0 7052.9 7097.0 4219.0 4222.9 4224.4 4308.9 4309.1 1752.0 1755.0 1785.5 1800.1 1807.1 815.7 865.8 914.7 934.1 936.4 15886.7 16069.8 16167.1 16306.3 16512.0 853.9 868.6 871.5 906.6 908.3 9126.0 9406.8 9424.7 9645.9 9652.0 366535.0 377081.0 378303.0 380537.0 387830.0 45905.6 60700.0 67529.3 70315.0 71056.3 878.2 887.5 900.5 905.3 924.3 14265.5 14433.3 14512.8 14599.6 14771.9 30903.2 31650.0 32493.2 32587.5 32836.0 47029.0 49125.0 49746.0 50034.2 50378.0 7328.2 7709.0 7718.5 7788.8 7833.3 11140.8 11618.5 11869.3 11974.2 12069.8 6023.5 8886.3 9888.3 10332.2 10664.7 10083.8 10087.8 10383.3 10450.8 10592.0 10118.2 10394.3 10613.9 10824.1 10949.2 7664.2 7701.7 7732.5 7795.5 7810.7 9805.5 10544.5 10679.1 10733.9 10852.3 05:27:10 INFO - PROCESS | 13017 | 05:27:10 INFO - PROCESS | 13017 | [#3] mootools.html Cycles:180 Average:5044.64 Median:6147.32 stddev:2577.45 (41.9%) stddev-sans-first:2569.06 05:27:10 INFO - PROCESS | 13017 | Values: 1270.2 1381.7 1404.3 1517.2 1714.8 6473.9 6928.2 7092.9 7100.4 7101.3 7016.1 7179.8 7181.2 7182.1 7184.6 1861.5 1899.4 2135.5 2152.6 2160.9 2071.9 2088.5 2088.9 2089.0 2089.2 2121.5 2130.4 2147.5 2214.3 2217.5 2135.4 2167.4 2179.8 2180.3 2202.1 2165.2 2193.8 2194.0 2197.2 2200.4 7303.5 7396.4 7397.3 7402.9 7403.6 4328.0 4444.0 4446.1 4452.2 4453.2 2703.7 2706.2 2844.2 2850.1 2886.0 918.2 932.6 938.1 953.1 972.7 9389.1 9402.3 9409.9 9440.9 9454.0 3947.2 3969.5 4028.5 4045.5 4052.5 8196.1 8207.7 8214.8 8217.4 8221.5 4477.9 4490.7 4494.0 4496.3 4497.3 3456.8 4021.8 4091.3 4098.6 4127.6 3291.2 3370.0 3391.2 3401.9 3422.5 1093.6 1099.0 1106.0 1107.3 1121.0 1146.8 1150.0 1157.3 1181.6 1222.9 6790.6 6818.2 6819.9 6844.7 6846.2 1010.3 1015.6 1046.6 1074.3 1074.4 5334.2 5357.0 5385.1 5390.9 5396.1 8437.9 8662.1 8721.4 8912.8 9052.1 8727.0 8926.8 8975.5 8984.6 8995.0 6664.0 6684.5 6772.6 6782.3 6827.4 6575.8 6626.4 6642.7 6669.8 6673.0 7475.3 7750.5 7815.5 7817.0 7824.6 7780.6 7923.6 8044.6 8047.9 8177.9 5483.8 5566.7 5576.0 6119.3 6211.3 5923.9 6954.1 6973.9 6985.5 6988.4 6352.3 6385.8 6443.5 6487.9 6533.1 6134.9 6250.3 6260.8 6276.1 6331.7 6514.3 6604.6 6617.4 6732.7 6737.6 6098.7 6119.4 6166.3 6182.4 6194.3 5846.0 5972.2 6006.9 6159.7 6211.5 05:27:10 INFO - PROCESS | 13017 | 05:27:10 INFO - PROCESS | 13017 | [#4] prototype.html Cycles:180 Average:4632.00 Median:5299.94 stddev:1360.21 (25.7%) stddev-sans-first:1324.72 05:27:10 INFO - PROCESS | 13017 | Values: 306.9 307.6 308.5 308.8 311.4 5234.0 5309.4 5309.6 5336.1 5352.9 5213.8 5271.8 5274.1 5284.3 5290.5 3940.4 4022.4 4103.8 4123.1 4126.8 4098.2 4105.9 4119.3 4127.5 4132.2 3910.5 4094.0 4094.2 4100.5 4101.5 3998.1 4051.6 4052.8 4070.7 4072.7 3565.0 3569.5 3572.2 3584.9 3585.1 4997.6 5015.0 5016.2 5047.9 5055.2 4710.0 4715.3 4715.9 4717.5 4721.6 5548.5 5552.2 5558.7 5560.0 5564.0 3859.9 3961.2 3961.3 3961.7 3973.4 5705.1 5847.6 5859.4 5859.5 5865.6 4052.7 4083.8 4085.1 4086.6 4087.7 4140.2 4144.8 4148.5 4150.6 4151.0 4704.0 4709.7 4718.4 4719.6 4725.4 5583.9 5587.1 5603.4 5604.5 5605.4 1443.3 1466.3 1469.3 1470.4 1472.3 937.7 972.2 975.9 995.1 996.2 4780.8 4816.0 4830.7 4833.8 4840.2 5731.1 5731.9 5737.6 5739.6 5743.7 4834.2 4837.6 4840.4 4841.6 4842.0 3043.0 3074.2 3076.4 3078.5 3082.4 5413.2 5430.1 5437.2 5439.1 5442.6 5759.2 5992.5 5994.9 6003.4 6005.8 5466.7 5498.9 5523.5 5534.9 5544.6 5826.5 5836.5 5841.8 5849.9 5852.7 5708.0 5713.3 5718.9 5722.3 5724.4 5372.1 5527.5 5530.4 5532.8 5536.2 3854.2 3942.7 3950.5 3950.8 3954.5 5745.3 5772.6 5798.7 5801.4 5810.5 5571.7 5582.2 5583.6 5590.2 5595.1 5581.2 5588.9 5596.1 5598.3 5599.8 5358.1 5511.5 5519.1 5531.6 5531.9 5637.1 5643.7 5647.4 5650.3 5652.7 5470.2 5506.6 5507.5 5508.3 5516.3 05:27:10 INFO - PROCESS | 13017 | 05:27:10 INFO - PROCESS | 13017 | [#5] yui.html Cycles:180 Average:12263.89 Median:50473.37 stddev:14100.13 (27.9%) stddev-sans-first:14112.80 05:27:10 INFO - PROCESS | 13017 | Values: 669.4 694.5 737.1 766.4 803.0 12278.2 12424.1 12442.4 12458.9 12494.6 11975.1 12036.8 12045.5 12046.1 12056.8 630.3 788.5 807.9 811.1 817.4 803.4 808.8 814.5 818.6 818.7 663.6 865.5 865.6 869.3 869.7 841.8 849.3 852.9 853.2 853.8 620.3 623.5 623.9 624.9 626.4 11282.2 11467.6 11477.1 11477.6 11500.7 11607.7 11720.5 11814.5 12275.3 12503.7 10656.1 10673.5 10848.1 10890.2 10930.2 3268.0 3295.5 3331.7 3339.2 3393.0 42097.0 42545.1 42624.4 42707.1 42717.1 8920.0 9014.6 9110.8 9775.7 9935.8 16142.2 16322.3 16329.1 16329.4 16330.9 6471.3 6622.6 6663.4 6724.8 6758.3 3568.0 3613.6 3615.0 3617.6 3633.1 2705.1 2725.2 2726.1 2735.5 2738.9 415.0 512.3 522.9 531.4 533.2 521.1 542.8 562.2 571.7 573.1 7335.3 7630.7 7754.2 7865.2 7928.9 494.6 515.3 570.9 573.9 574.5 3504.5 3584.8 3592.4 3614.8 3772.7 49534.5 50040.7 50116.7 50414.5 50532.2 43568.6 46072.0 46084.3 46104.3 46231.3 40407.8 40588.4 41283.4 41584.2 41665.4 7207.2 7228.7 7279.3 7305.5 7448.6 31906.0 32097.4 32213.4 32764.3 32837.8 37485.3 39031.0 39605.6 39651.8 39702.6 8906.7 8978.6 9004.8 9046.3 9096.0 9791.7 9844.6 9865.5 9916.9 10042.3 8824.1 8937.0 9141.7 10023.4 10271.7 10097.5 10361.7 10442.6 10521.7 10732.8 9582.7 9747.7 9931.3 10243.2 10331.6 8003.7 8104.6 8183.0 8246.8 8295.3 8053.8 8250.3 8302.1 8427.7 8432.2 05:27:10 INFO - PROCESS | 13017 | -------- Summary: end -------- 05:27:10 INFO - PROCESS | 13017 | 05:27:11 INFO - TEST-INFO | 13017: exit 0 05:27:11 INFO - TEST-OK | dromaeo_css | took 1116695ms 05:27:11 INFO - TEST-START | kraken 05:27:11 INFO - operating with platform_type : linux_ 05:27:11 INFO - Initialising browser for kraken test... 05:27:11 INFO - TEST-INFO | started process 13200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLc4GmW/profile http://localhost:48819/getInfo.html) 05:27:15 INFO - PROCESS | 13200 | __metrics Screen width/height:1600/1200 05:27:15 INFO - PROCESS | 13200 | colorDepth:24 05:27:15 INFO - PROCESS | 13200 | Browser inner width/height: 1024/697 05:27:15 INFO - PROCESS | 13200 | __metrics 05:27:16 ERROR - PROCESS | 13200 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:27:17 INFO - TEST-INFO | 13200: exit 0 05:27:17 INFO - Browser initialized. 05:27:17 INFO - Running cycle 1/1 for kraken test... 05:27:17 INFO - TEST-INFO | started process 13283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLc4GmW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:29 INFO - PROCESS | 13283 | RSS: Main: 155193344 05:27:29 INFO - PROCESS | 13283 | 05:27:31 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48819/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:32 INFO - PROCESS | 13283 | RSS: Main: 195801088 05:27:32 INFO - PROCESS | 13283 | 05:27:35 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48819/tests/kraken/driver.html?testName=audio-dft) 05:27:35 INFO - PROCESS | 13283 | RSS: Main: 185581568 05:27:35 INFO - PROCESS | 13283 | 05:27:38 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48819/tests/kraken/driver.html?testName=audio-fft) 05:27:39 INFO - PROCESS | 13283 | RSS: Main: 171569152 05:27:39 INFO - PROCESS | 13283 | 05:27:41 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48819/tests/kraken/driver.html?testName=audio-oscillator) 05:27:42 INFO - PROCESS | 13283 | RSS: Main: 172208128 05:27:42 INFO - PROCESS | 13283 | 05:27:44 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48819/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:44 INFO - PROCESS | 13283 | RSS: Main: 174391296 05:27:44 INFO - PROCESS | 13283 | 05:27:47 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48819/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:48 INFO - PROCESS | 13283 | RSS: Main: 174268416 05:27:48 INFO - PROCESS | 13283 | 05:27:52 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48819/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:52 INFO - PROCESS | 13283 | RSS: Main: 174354432 05:27:52 INFO - PROCESS | 13283 | 05:27:55 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48819/tests/kraken/driver.html?testName=json-parse-financial) 05:27:56 INFO - PROCESS | 13283 | RSS: Main: 174624768 05:27:56 INFO - PROCESS | 13283 | 05:27:57 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48819/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:58 INFO - PROCESS | 13283 | RSS: Main: 185786368 05:27:58 INFO - PROCESS | 13283 | 05:28:00 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:00 INFO - PROCESS | 13283 | RSS: Main: 183123968 05:28:00 INFO - PROCESS | 13283 | 05:28:02 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:03 INFO - PROCESS | 13283 | RSS: Main: 196231168 05:28:03 INFO - PROCESS | 13283 | 05:28:06 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:06 INFO - PROCESS | 13283 | RSS: Main: 200568832 05:28:06 INFO - PROCESS | 13283 | 05:28:09 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:09 INFO - PROCESS | 13283 | RSS: Main: 200323072 05:28:09 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48819/tests/kraken/driver.html?testName=ai-astar) 05:28:11 INFO - PROCESS | 13283 | RSS: Main: 262418432 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | __start_tp_report 05:28:11 INFO - PROCESS | 13283 | _x_x_mozilla_page_load 05:28:11 INFO - PROCESS | 13283 | _x_x_mozilla_page_load_details 05:28:11 INFO - PROCESS | 13283 | |i|pagename|runs| 05:28:11 INFO - PROCESS | 13283 | |0;ai-astar;113;115;108;112;112;113;101;111;113;112 05:28:11 INFO - PROCESS | 13283 | |1;audio-beat-detection;161;131;165;181;134;167;157;134;177;137 05:28:11 INFO - PROCESS | 13283 | |2;audio-dft;160;161;163;163;161;161;163;160;161;161 05:28:11 INFO - PROCESS | 13283 | |3;audio-fft;73;73;103;97;75;74;74;127;98;74 05:28:11 INFO - PROCESS | 13283 | |4;audio-oscillator;95;95;138;95;94;95;135;94;93;139 05:28:11 INFO - PROCESS | 13283 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;117 05:28:11 INFO - PROCESS | 13283 | |6;imaging-darkroom;146;146;146;146;145;146;151;146;145;146 05:28:11 INFO - PROCESS | 13283 | |7;imaging-desaturate;96;95;97;95;95;95;95;95;96;95 05:28:11 INFO - PROCESS | 13283 | |8;json-parse-financial;64;64;64;64;66;65;66;73;63;63 05:28:11 INFO - PROCESS | 13283 | |9;json-stringify-tinderbox;63;63;64;62;64;64;63;63;64;63 05:28:11 INFO - PROCESS | 13283 | |10;stanford-crypto-aes;83;84;84;84;84;82;88;81;83;84 05:28:11 INFO - PROCESS | 13283 | |11;stanford-crypto-ccm;119;125;116;123;124;117;119;125;116;115 05:28:11 INFO - PROCESS | 13283 | |12;stanford-crypto-pbkdf2;142;129;141;133;133;134;140;148;142;130 05:28:11 INFO - PROCESS | 13283 | |13;stanford-crypto-sha256-iterative;68;69;67;67;67;66;66;68;68;65 05:28:11 INFO - PROCESS | 13283 | __end_tp_report 05:28:11 INFO - PROCESS | 13283 | __start_cc_report 05:28:11 INFO - PROCESS | 13283 | _x_x_mozilla_cycle_collect,1173 05:28:11 INFO - PROCESS | 13283 | __end_cc_report 05:28:11 INFO - PROCESS | 13283 | __startTimestamp1459859291754__endTimestamp 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | ------- Summary: start ------- 05:28:11 INFO - PROCESS | 13283 | Number of tests: 14 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.50 stddev:3.94 (3.5%) stddev-sans-first:4.12 05:28:11 INFO - PROCESS | 13283 | Values: 113.0 115.0 108.0 112.0 112.0 113.0 101.0 111.0 113.0 112.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:163.00 stddev:18.92 (11.6%) stddev-sans-first:19.92 05:28:11 INFO - PROCESS | 13283 | Values: 161.0 131.0 165.0 181.0 134.0 167.0 157.0 134.0 177.0 137.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.13 05:28:11 INFO - PROCESS | 13283 | Values: 160.0 161.0 163.0 163.0 161.0 161.0 163.0 160.0 161.0 161.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#3] audio-fft Cycles:10 Average:86.80 Median:74.00 stddev:18.62 (25.2%) stddev-sans-first:19.07 05:28:11 INFO - PROCESS | 13283 | Values: 73.0 73.0 103.0 97.0 75.0 74.0 74.0 127.0 98.0 74.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.50 stddev:20.76 (22.0%) stddev-sans-first:21.53 05:28:11 INFO - PROCESS | 13283 | Values: 95.0 95.0 138.0 95.0 94.0 95.0 135.0 94.0 93.0 139.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:28:11 INFO - PROCESS | 13283 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.70 (1.2%) stddev-sans-first:1.80 05:28:11 INFO - PROCESS | 13283 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 151.0 146.0 145.0 146.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:28:11 INFO - PROCESS | 13283 | Values: 96.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:64.50 stddev:2.94 (4.6%) stddev-sans-first:3.08 05:28:11 INFO - PROCESS | 13283 | Values: 64.0 64.0 64.0 64.0 66.0 65.0 66.0 73.0 63.0 63.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 05:28:11 INFO - PROCESS | 13283 | Values: 63.0 63.0 64.0 62.0 64.0 64.0 63.0 63.0 64.0 63.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.83 (2.2%) stddev-sans-first:1.92 05:28:11 INFO - PROCESS | 13283 | Values: 83.0 84.0 84.0 84.0 84.0 82.0 88.0 81.0 83.0 84.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:121.00 stddev:3.98 (3.3%) stddev-sans-first:4.21 05:28:11 INFO - PROCESS | 13283 | Values: 119.0 125.0 116.0 123.0 124.0 117.0 119.0 125.0 116.0 115.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:140.50 stddev:6.23 (4.4%) stddev-sans-first:6.36 05:28:11 INFO - PROCESS | 13283 | Values: 142.0 129.0 141.0 133.0 133.0 134.0 140.0 148.0 142.0 130.0 05:28:11 INFO - PROCESS | 13283 | 05:28:11 INFO - PROCESS | 13283 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.20 (1.8%) stddev-sans-first:1.22 05:28:11 INFO - PROCESS | 13283 | Values: 68.0 69.0 67.0 67.0 67.0 66.0 66.0 68.0 68.0 65.0 05:28:11 INFO - PROCESS | 13283 | -------- Summary: end -------- 05:28:11 INFO - PROCESS | 13283 | 05:28:12 INFO - TEST-INFO | 13283: exit 0 05:28:12 INFO - TEST-OK | kraken | took 61739ms 05:28:12 INFO - SUITE-END | took 1178s 05:28:12 INFO - Completed test suite (00:19:38) 05:28:12 INFO - javascript benchmark 05:28:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2585.185666515048, 2663.081236973245, 2667.746564076413, 2670.772984296335, 2703.324168957761, 4445.933311000337, 4590.63274938005, 4606.56237657422, 4635.814567417299, 4641.280601506767, 4522.8643140705835, 4562.429696287964, 4587.495375508692, 4609.585137337639, 4668.696534725241, 4185.958140418603, 4206.179794939988, 4215.831366745334, 4301.935470967938, 4383.298672212431, 4056.290149223874, 4273.542445129254, 4312.568743125678, 4325.048489332357, 4325.697201195918, 4165.208610364021, 4210.32634778437, 4211.220924129046, 4238.788060596958, 4259.105587826529, 4254.234237837188, 4254.468191476066, 4265.466816647919, 4283.678724095706, 4300.956990430087, 4138.296489596776, 4234.55537168599, 4242.384854196124, 4242.660587153051, 4287.935680964788, 4464.8214071437105, 4488.7531185784765, 4508.932366014513, 4516.029053753426, 4558.407407037064, 4891.828785992473, 4916.0905232532095, 4917.975410122926, 4919.754012299407, 4922.0402021605805, 4763.380760501147, 4910.705357678551, 4929.852104436873, 4994.026164897847, 5021.020900924321, 4563.452385713669, 4621.838235661736, 4622.907541849144, 4625.537446255347, 4626.0, 5004.574611158092, 5005.674631148963, 5006.224035274538, 5008.098542262428, 5039.496050394931, 4689.62483001359, 4803.207470767354, 4803.783829727601, 4805.687630304019, 4819.108464933998, 4898.4121905371585, 4901.803927842846, 4918.262260660929, 4942.159832828356, 4948.579370753526, 4846.975765121152, 4855.393075865517, 4857.149998750205, 4864.270359446112, 4896.926546101811, 4656.883577910579, 4770.904581908342, 4814.9518504814505, 4819.228923372244, 4867.488913664085, 4140.171965606891, 4151.0, 4176.519700234512, 4205.600467955601, 4206.242876282298, 3601.9099522511624, 3606.4770608261656, 3646.726495512794, 3648.1244501319493, 3648.7810731356203, 4119.773412462343, 4161.2509748245, 4167.770772607536, 4190.476190476191, 4194.2869712149, 4931.334269873521, 4933.654644174873, 4934.851954441372, 4948.653594248368, 4992.90014199714, 4219.767912764827, 4236.279832428495, 4247.10810729744, 4248.34150706641, 4289.206496798102, 4411.448568928884, 4445.177642136216, 4499.392582001388, 4516.638668906479, 4541.9545804542195, 4716.1510928033285, 4717.174494463524, 4717.504662010508, 4726.905461890812, 4745.644076694192, 4928.827491037797, 4937.407511098691, 4938.259261110862, 4942.4069111705385, 4992.226204938241, 4600.332951722048, 4649.256119020941, 4701.318308845267, 4722.834700785456, 4747.192977193954, 4831.758412079312, 4837.661363704507, 4844.563989240844, 4854.902901942012, 4902.2156454967035, 4906.092372911023, 4923.4584195737725, 4925.852224433273, 4929.038837426668, 4982.153033984304, 4667.836625718083, 4729.645276604338, 4787.640926930564, 4818.638602104786, 4834.226523756182, 4680.46174689915, 4716.976415117902, 4737.28940658904, 4744.833930812405, 4798.568128868418, 4620.930686039645, 4646.395968524071, 4656.185167595725, 4688.953110468988, 4698.483166851712, 4736.5973892219545, 4745.359376484131, 4813.831515897067, 4830.95169048305, 4922.1140194765285, 4720.197566413649, 4724.244120940633, 4726.3146843708155, 4729.0, 4767.69010014348], "unit": "score", "name": "dojo.html", "value": 4514.314170236696}, {"lowerIsBetter": false, "replicates": [541.5153437673282, 541.5369858770752, 564.0918121823863, 576.5906206593319, 619.21050660408, 29149.27126821828, 29814.552781708266, 29858.95493657725, 37530.81234593823, 38589.42115868264, 41461.0, 41946.7902660487, 41981.740547783615, 41992.79003604985, 42003.36994945078, 7778.338841198505, 7955.562444065574, 7962.283394494494, 7964.247865469616, 7965.561894095822, 7676.731314403997, 7809.258120478546, 7811.648475818602, 7811.843763124734, 7815.218478152196, 7796.649150788228, 7859.70314898044, 7867.7246296379635, 7873.055233371975, 7874.291313781759, 7747.535147891116, 7807.492512986694, 7809.921900781004, 7811.765647030598, 7813.0, 7874.212578742137, 8010.719624813162, 8015.95992020042, 8018.919810801875, 8022.638981245799, 37355.25289494222, 37703.81148094269, 37805.0, 37809.0, 37812.0, 2868.282929267683, 2914.7085291470894, 3112.7821052526333, 3173.3335999439914, 3221.01758963516, 28431.857840710873, 28443.715562844314, 29091.56362654562, 29138.562921555982, 29898.40203195924, 3447.4828775683595, 3502.964970350289, 3511.9648803511895, 3541.1855273287288, 3648.3068217038945, 229313.56029659568, 229314.0, 229742.0, 229828.85085574634, 231757.9999999983, 41979.0, 54929.72535137379, 55343.72328138333, 55352.723236384365, 55401.445985540435, 41455.0, 41663.375049374285, 41663.7916810414, 41679.58320416818, 41742.1651566967, 12827.679308017188, 13140.474381024653, 13148.145370551076, 13150.868491315156, 13158.934205328913, 9905.0, 10033.548490317808, 10042.899571004342, 10043.397396156108, 10045.547950342252, 14690.192039437934, 14779.0, 14870.70258594822, 14874.256287185814, 14995.775063374058, 5670.432956704297, 5716.399778023331, 5737.672150152985, 5843.1235314703135, 5919.0, 901.7520181949885, 949.7768024514234, 958.8417911044739, 989.5771173966702, 1053.2942928238099, 26437.0, 26791.330216744736, 27412.314692132855, 27465.45069098607, 27518.449631007268, 802.418246771098, 988.268681175939, 1042.3537406807827, 1054.9736256593646, 1131.5417256011328, 13591.932040339932, 13822.516211932534, 13932.98323832883, 14079.225642589756, 14220.71558568823, 281664.0, 374166.0, 379341.0, 379596.0, 380314.0, 50665.746671267145, 51303.230451543255, 51647.225291620656, 51650.0, 51734.74132629313, 1061.1192710050639, 1170.9063274937985, 1231.6612931443924, 1254.4166962362544, 1259.118616968126, 26295.60556591691, 28539.0, 29115.126546203646, 29280.70719292865, 29307.41385172327, 38366.232675346895, 38980.41529377005, 38999.415008774326, 38999.41500877546, 39028.6097139025, 166665.0, 167232.0, 167384.0, 167481.0, 171892.0, 26795.598066028637, 30891.227719307197, 31013.689863101983, 31228.687713123487, 31671.40764589168, 34757.0, 34960.650393495736, 35632.10919727028, 35871.64128358683, 35972.28055438824, 30247.848760756056, 30303.0, 30662.846685766428, 31384.686153138176, 32851.0, 32260.19349516281, 32658.346833063682, 35918.0, 36747.44878826873, 37420.43869341908, 32357.35285294234, 32705.672943270263, 32883.8355808229, 32990.0, 33099.83450082831, 28674.856625716737, 28892.85553572219, 29099.563506546994, 29164.854175728986, 29191.7080829189, 23474.647880281467, 24637.630435543124, 24650.753492464846, 24799.876000619883, 25047.373815654755], "unit": "score", "name": "ext.html", "value": 16487.588993591893}, {"lowerIsBetter": false, "replicates": [337.6522182152383, 345.9310729844779, 347.7166109620657, 351.3991075261303, 352.3833291739456, 15032.774508382356, 15385.07689538627, 15986.200689965513, 16020.519384418487, 16109.83890161098, 15290.46483373082, 15423.460178893742, 15585.532434026969, 15974.361025558992, 16003.679926401464, 4497.14554234696, 4627.051454451846, 4638.327442520833, 4638.373819534353, 4648.023914977842, 5093.388793344785, 5322.0, 5324.387695415019, 5325.600579956499, 5328.040952628526, 5252.159654455288, 5284.2866213061125, 5288.894222115556, 5293.0, 5294.047071527124, 5089.3638295213095, 5291.788328466857, 5297.046531624306, 5300.416954135023, 5303.416624171338, 5073.2897394364445, 5096.0, 5097.0, 5158.200478925773, 5166.896662066738, 12507.0, 18558.536036599056, 19704.40886773399, 19747.308844190527, 19755.506112347164, 1843.373253093941, 1914.9712754308557, 1954.2671498188179, 2187.0377034104945, 2248.5615305015526, 9038.638454461814, 9069.909300906973, 9190.310726695525, 9190.310726695525, 9203.493807840567, 1686.5277722237793, 1747.3884140550833, 1752.1326943163087, 1854.7125195594704, 1857.6934805757035, 54137.45862541364, 56065.0, 58782.11826822601, 59068.0, 61499.6925015372, 9622.566984485715, 9653.372530785617, 9654.379607647132, 9707.757306067404, 9715.222782177409, 13009.609711708665, 13102.80345794814, 13131.212127272394, 13134.408951597201, 13156.736865262641, 6947.930520694829, 6970.51206415546, 7061.646917654097, 7177.1746249182015, 7181.3177748114895, 6781.287964763727, 6967.268436814163, 7027.964860175666, 7052.929470705228, 7096.964515177391, 4218.978905105516, 4222.852200172979, 4224.429701990253, 4308.913821723548, 4309.095090031066, 1751.9562010949574, 1755.0, 1785.526835388623, 1800.0549711401356, 1807.1235450806348, 815.7308088330836, 865.787881968909, 914.7347269291964, 934.0845970948372, 936.3632729743704, 15886.682266354608, 16069.758953615705, 16167.110808905623, 16306.266218020217, 16512.0, 853.8591132463198, 868.6308318964415, 871.538084815049, 906.5648488725317, 908.2552307108108, 9126.041765614647, 9406.824146981628, 9424.717258482257, 9645.9035409645, 9651.951740241253, 366535.0, 377081.0, 378303.0, 380537.0, 387830.0, 45905.58694663838, 60700.0, 67529.32470675328, 70315.0, 71056.28943710496, 878.1920633017639, 887.4773678430477, 900.4597241655085, 905.316486053039, 924.3298608508777, 14265.502122277012, 14433.278336083364, 14512.782308265596, 14599.635009124857, 14771.92614036966, 30903.2274193147, 31650.0, 32493.18767030843, 32587.511187331736, 32836.0, 47029.0, 49125.0, 49746.0, 50034.249486258464, 50378.0, 7328.157261914948, 7708.961455192688, 7718.536887786526, 7788.766337009899, 7833.255840695125, 11140.832887506533, 11618.535258589562, 11869.347185904859, 11974.221675591407, 12069.75860482803, 6023.48800351975, 8886.289096872106, 9888.258380621339, 10332.17342612574, 10664.733381665521, 10083.848742269018, 10087.848682269918, 10383.273170877967, 10450.790984180427, 10591.993760592732, 10118.241131914989, 10394.272400932165, 10613.9469302653, 10824.079953204066, 10949.178811589321, 7664.156942736183, 7701.730439434593, 7732.497387669783, 7795.532268063935, 7810.687572497037, 9805.460699661588, 10544.52549635253, 10679.14566834667, 10733.892661073602, 10852.348859068165], "unit": "score", "name": "jquery.html", "value": 7905.475843139981}, {"lowerIsBetter": false, "replicates": [1270.2251626507834, 1381.7443772902013, 1404.2978510744624, 1517.2034681792065, 1714.7856517935259, 6473.902891456626, 6928.203256625489, 7092.85814283714, 7100.360967512923, 7101.325374089466, 7016.052832867574, 7179.820504487378, 7181.210066892638, 7182.066331376914, 7184.640767961607, 1861.5160058384781, 1899.3921944977612, 2135.508832968418, 2152.62329092409, 2160.8595441296266, 2071.8860462674547, 2088.5196404826897, 2088.853780235384, 2089.049482485473, 2089.19565967103, 2121.469632591852, 2130.424785307966, 2147.5275439403385, 2214.2803588833694, 2217.4678077261424, 2135.4234356723596, 2167.4147980045377, 2179.7711240319695, 2180.2805074325433, 2202.064122747826, 2165.177232651598, 2193.7696541863033, 2194.0455901682817, 2197.2419515267366, 2200.3508964855405, 7303.488755787097, 7396.408287337, 7397.2602739726135, 7402.925970740332, 7403.629818509107, 4327.956720432787, 4443.977780111111, 4446.110777844444, 4452.1540907227845, 4453.198424283628, 2703.743144401298, 2706.242252169376, 2844.1609725131134, 2850.1307101334087, 2885.9855700721573, 918.1552971266451, 932.6129656192672, 938.1041105743998, 953.1183655119056, 972.7373609125567, 9389.061093890625, 9402.294827887936, 9409.905900940972, 9440.858387124199, 9454.0, 3947.230290093404, 3969.523657161159, 4028.4762980812307, 4045.5145382554283, 4052.452918855917, 8196.139405362352, 8207.71273005442, 8214.8357032859, 8217.424780265444, 8221.465604735673, 4477.865664030084, 4490.685652004394, 4494.0, 4496.303073023687, 4497.280435130363, 3456.7753096048677, 4021.8391264349098, 4091.284025295561, 4098.610631989956, 4127.5666055064385, 3291.1607540077125, 3369.983150084234, 3391.236971681352, 3401.863925443004, 3422.5208470814105, 1093.6281664234039, 1098.9670309890716, 1105.9612913548149, 1107.3245320354577, 1120.9831852522218, 1146.8279758036194, 1150.0339714639742, 1157.2824848593925, 1181.5569161564413, 1222.9205101668363, 6790.5925644461495, 6818.215905170969, 6819.897701534481, 6844.726210951506, 6846.246912839583, 1010.3180353261666, 1015.603914473356, 1046.602291129366, 1074.2587614546094, 1074.3607553505651, 5334.199870019528, 5357.035733567917, 5385.138377859524, 5390.8921821563345, 5396.1366181410785, 8437.915620843713, 8662.133786621413, 8721.433106848035, 8912.821743565093, 9052.140046695553, 8727.04002559718, 8926.776830579287, 8975.50634715097, 8984.595693193822, 8995.0, 6663.966680166568, 6684.465242780566, 6772.627505487246, 6782.287859774653, 6827.385535301847, 6575.80272591823, 6626.4367528760595, 6642.667866606747, 6669.833254168685, 6673.032410300576, 7475.289847464483, 7750.457467977188, 7815.491993020435, 7817.0, 7824.569648669378, 7780.610969451392, 7923.603819809102, 8044.597770111588, 8047.919520804717, 8177.918220817715, 5483.835484935458, 5566.666000039849, 5576.024195765806, 6119.265688117454, 6211.2857021443115, 5923.881522369615, 6954.130733658293, 6973.919042548413, 6985.511014228955, 6988.40598549129, 6352.269489008823, 6385.808425747235, 6443.548951573345, 6487.935120648733, 6533.118029066015, 6134.938650613437, 6250.312465628868, 6260.812175634738, 6276.121343012073, 6331.6517591531065, 6514.2834288229205, 6604.603723776589, 6617.43751781104, 6732.697028633625, 6737.562058466184, 6098.725557349841, 6119.418655227746, 6166.321704612399, 6182.381761823782, 6194.349593292639, 5845.970770146122, 5972.223610930551, 6006.948783962702, 6159.692015399122, 6211.472024877936], "unit": "score", "name": "mootools.html", "value": 4171.0126913391605}, {"lowerIsBetter": false, "replicates": [306.8849181556916, 307.6477433338827, 308.51717062796723, 308.78385130408714, 311.3850145961726, 5234.005538947602, 5309.362876454826, 5309.575233981287, 5336.119540275859, 5352.91970620441, 5213.765380557875, 5271.789128434868, 5274.05067087925, 5284.339457567795, 5290.523852853243, 3940.4089386592095, 4022.4368588397647, 4103.774292413916, 4123.072308730541, 4126.793660316987, 4098.159877225176, 4105.856295029675, 4119.320312148507, 4127.504699436072, 4132.152908653718, 3910.511186101737, 4094.0379010932406, 4094.2425651254466, 4100.528439229482, 4101.487314085739, 3998.1403998140395, 4051.6353528182312, 4052.7770972596495, 4070.653994410479, 4072.735272207297, 3565.0, 3569.464580312948, 3572.214112895159, 3584.910377240564, 3585.0678823505814, 4997.600191984632, 5015.0471410432265, 5016.172331565287, 5047.873803154914, 5055.216441451544, 4709.95290047102, 4715.292706094114, 4715.905681886377, 4717.528247175289, 4721.622270218374, 5548.472895074961, 5552.194931734916, 5558.749856256478, 5559.972200139014, 5563.972180139114, 3859.903502412434, 3961.1681546875193, 3961.3067713150085, 3961.7424867383816, 3973.3642617181113, 5705.115707065412, 5847.590668653196, 5859.355470898197, 5859.472647461749, 5865.58940874139, 4052.7163098583405, 4083.7549747015273, 4085.080856807254, 4086.5504794472586, 4087.7138600297694, 4140.213359461693, 4144.8134833932545, 4148.502179738391, 4150.584941505826, 4150.979245103756, 4704.0, 4709.740964246999, 4718.363020992122, 4719.598834099072, 4725.432948046257, 5583.888322233533, 5587.078132108238, 5603.411641777555, 5604.495595396434, 5605.439456054362, 1443.336065409923, 1466.281522054207, 1469.2580246975422, 1470.3824393754649, 1472.3006571878273, 937.6530683647094, 972.1785091597588, 975.9072888075622, 995.0894931137927, 996.2378780233128, 4780.832670856504, 4816.0, 4830.686005409637, 4833.806647734122, 4840.177169881129, 5731.140328950691, 5731.8853622928145, 5737.627054241461, 5739.598228124075, 5743.741531631086, 4834.226523756182, 4837.564619184291, 4840.370751802243, 4841.588464980446, 4842.031593681278, 3042.9847850760602, 3074.1546074829153, 3076.3693442844165, 3078.4920488119656, 3082.4143412751505, 5413.188021796762, 5430.0768869292315, 5437.184422336682, 5439.129739241703, 5442.564594832404, 5759.222504961776, 5992.460678538865, 5994.880102397928, 6003.429674180946, 6005.759769609254, 5466.72666366688, 5498.945010549924, 5523.475269849358, 5534.861628459321, 5544.63959842609, 5826.504747096545, 5836.533077353886, 5841.824745257649, 5849.912251316148, 5852.707364631837, 5707.971460142673, 5713.314402271754, 5718.885622287447, 5722.284714410699, 5724.3703192647945, 5372.086745253238, 5527.50252477279, 5530.364008139116, 5532.806351777668, 5536.197251398444, 3854.2484215577692, 3942.6648734856713, 3950.4666869973335, 3950.762954222756, 3954.525456945185, 5745.3105627324985, 5772.595918285848, 5798.652080875161, 5801.36185019639, 5810.5061069809535, 5571.749271282721, 5582.218489411567, 5583.553315734813, 5590.161475778666, 5595.07681232592, 5581.218629391808, 5588.86027849307, 5596.076647353304, 5598.272224610774, 5599.80400685974, 5358.115910874662, 5511.5039646432015, 5519.116941289374, 5531.612787104864, 5531.944680553143, 5637.069883469346, 5643.71781410936, 5647.350554686263, 5650.3219613646625, 5652.7173641318595, 5470.206820011155, 5506.614536982533, 5507.476789704971, 5508.283923090133, 5516.255305533862], "unit": "score", "name": "prototype.html", "value": 4197.534483136251}, {"lowerIsBetter": false, "replicates": [669.4142625202948, 694.5138403117819, 737.1412304665065, 766.3562607409775, 803.020315215437, 12278.201916875409, 12424.068194885374, 12442.44009019594, 12458.875411245896, 12494.625161245154, 11975.101867359961, 12036.81944770829, 12045.518179272818, 12046.096542759284, 12056.819147712791, 630.3161070238785, 788.4756636836497, 807.9111297757242, 811.0915774332726, 817.3951276055735, 803.4175222963363, 808.7937575918132, 814.5316443045273, 818.5907046476761, 818.7339114787688, 663.6416335178998, 865.5196366016858, 865.5542395666206, 869.2871845087031, 869.7260362985671, 841.7895526118471, 849.3332733803934, 852.9232369086812, 853.2448782827181, 853.8206976534904, 620.2742790934617, 623.5448122870284, 623.9438450539428, 624.9468795152418, 626.3736263736264, 11282.210245282833, 11467.598634047768, 11477.139214558942, 11477.598284060101, 11500.712482187928, 11607.709807254801, 11720.531178752839, 11814.527418903233, 12275.263484190888, 12503.74992500154, 10656.09423199029, 10673.519691613896, 10848.132149428027, 10890.183236257313, 10930.153723709996, 3267.983660081708, 3295.538624592559, 3331.68349006844, 3339.2152844081866, 3392.9990652757497, 42097.0, 42545.149097017886, 42624.36063459051, 42707.14585708299, 42717.14565708699, 8920.0, 9014.639414423349, 9110.772230694152, 9775.706728798148, 9935.80128397428, 16142.192890355434, 16322.265498052617, 16329.10189939541, 16329.428470003493, 16330.918345408198, 6471.288158302583, 6622.5695329804375, 6663.433608143265, 6724.798256052326, 6758.324167583202, 3568.0, 3613.584437789688, 3615.023943535231, 3617.620149884277, 3633.066254403821, 2705.147878418292, 2725.1552018874213, 2726.1140129458004, 2735.466584016098, 2738.890444382242, 414.97925103744694, 512.3032675561234, 522.8901930594542, 531.4340227657532, 533.226821109393, 521.0906967342013, 542.8317221661298, 562.2072877243068, 571.6941436331542, 573.1402895656515, 7335.339819416278, 7630.7329243477325, 7754.18581048993, 7865.213478652204, 7928.920710792819, 494.6110287312273, 515.3069122030862, 570.8829689913558, 573.8938296415176, 574.4800955135609, 3504.5268888700207, 3584.8386822593047, 3592.4252119660728, 3614.7650402724266, 3772.660460558508, 49534.50465495299, 50040.749796250784, 50116.749416252685, 50414.495855041714, 50532.24201636978, 43568.56431435645, 46072.0, 46084.308735369, 46104.308435373496, 46231.3065304014, 40407.79796101001, 40588.39117413241, 41283.380749288786, 41584.1683166335, 41665.37501937473, 7207.243239459991, 7228.710851565878, 7279.308465695751, 7305.452091093083, 7448.590327531821, 31906.0, 32097.35805283928, 32213.35573288568, 32764.34471310513, 32837.83581082079, 37485.25029499449, 39031.0, 39605.603943961345, 39651.80174099226, 39702.60297396989, 8906.73279801607, 8978.640854365753, 9004.819903602021, 9046.276297896284, 9095.95452022762, 9791.657291994747, 9844.556994935389, 9865.457399843077, 9916.900830991597, 10042.297039207186, 8824.11758824138, 8936.955315223382, 9141.725748227564, 10023.398596084258, 10271.691849244535, 10097.495125243855, 10361.74095647615, 10442.63450779219, 10521.736956576147, 10732.839007415052, 9582.66460673873, 9747.707568772948, 9931.255155863195, 10243.180545556188, 10331.586736530455, 8003.719869804529, 8104.554249516097, 8183.0, 8246.793830154294, 8295.294899933573, 8053.758387248392, 8250.257476827115, 8302.128276530877, 8427.662893484438, 8432.156784321764], "unit": "score", "name": "yui.html", "value": 5674.317294236827}], "name": "dromaeo_css", "value": 6229.859873204535}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 108.0, 112.0, 112.0, 113.0, 101.0, 111.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [161.0, 131.0, 165.0, 181.0, 134.0, 167.0, 157.0, 134.0, 177.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 154.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 163.0, 163.0, 161.0, 161.0, 163.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 103.0, 97.0, 75.0, 74.0, 74.0, 127.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 138.0, 95.0, 94.0, 95.0, 135.0, 94.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 151.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 66.0, 65.0, 66.0, 73.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 65.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 62.0, 64.0, 64.0, 63.0, 63.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 84.0, 84.0, 82.0, 88.0, 81.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [119.0, 125.0, 116.0, 123.0, 124.0, 117.0, 119.0, 125.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.9}, {"lowerIsBetter": true, "replicates": [142.0, 129.0, 141.0, 133.0, 133.0, 134.0, 140.0, 148.0, 142.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1515.7999999999997}]} 05:28:12 INFO - Return code: 0 05:28:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:13 ERROR - # TBPL SUCCESS # 05:28:13 INFO - Running post-action listener: _resource_record_post_action 05:28:13 INFO - Running post-run listener: _resource_record_post_run 05:28:14 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518475776; Read time: 12; Write time: 424292 05:28:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233279488; Read time: 0; Write time: 256072 05:28:14 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285196288; Read time: 12; Write time: 168220 05:28:14 INFO - Running post-run listener: _upload_blobber_files 05:28:14 INFO - Blob upload gear active. 05:28:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:14 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 05:28:14 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'] 05:28:14 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 05:28:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:28:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:28:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:15 INFO - (blobuploader) - INFO - Done attempting. 05:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:16 INFO - (blobuploader) - INFO - Done attempting. 05:28:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:16 INFO - Return code: 0 05:28:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4d57a806b6719de59e6da16294433060d60ee7b20b41fff2567cd76a357ca775637527a0bc2bcf6b7fa21a5c29e0f04eee12e5ff3c73d464d82dc916d2bf8e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66752d8eea2b90ecad7d84e53a106da9611940dd6a1a13a53b0a1ecae1a74e6cb6d7989f255dfd4e2d20909362268a8477d22f99db3a40095b36fdcde2bab1d7"} 05:28:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:16 INFO - Contents: 05:28:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4d57a806b6719de59e6da16294433060d60ee7b20b41fff2567cd76a357ca775637527a0bc2bcf6b7fa21a5c29e0f04eee12e5ff3c73d464d82dc916d2bf8e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66752d8eea2b90ecad7d84e53a106da9611940dd6a1a13a53b0a1ecae1a74e6cb6d7989f255dfd4e2d20909362268a8477d22f99db3a40095b36fdcde2bab1d7"} 05:28:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:16 INFO - Copying logs to upload dir... 05:28:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.029992 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-05 05:28:16.067267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 05:28:16.071053) ========= 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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 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/c4d57a806b6719de59e6da16294433060d60ee7b20b41fff2567cd76a357ca775637527a0bc2bcf6b7fa21a5c29e0f04eee12e5ff3c73d464d82dc916d2bf8e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66752d8eea2b90ecad7d84e53a106da9611940dd6a1a13a53b0a1ecae1a74e6cb6d7989f255dfd4e2d20909362268a8477d22f99db3a40095b36fdcde2bab1d7"} build_url:https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/ebE1Wz_QScOd0LMuztA-gA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c4d57a806b6719de59e6da16294433060d60ee7b20b41fff2567cd76a357ca775637527a0bc2bcf6b7fa21a5c29e0f04eee12e5ff3c73d464d82dc916d2bf8e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/66752d8eea2b90ecad7d84e53a106da9611940dd6a1a13a53b0a1ecae1a74e6cb6d7989f255dfd4e2d20909362268a8477d22f99db3a40095b36fdcde2bab1d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 05:28:16.099208) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:28:16.099945) ========= 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=574dc5aafe09851ec43d388c000001b6-1459858059.486649-394257811 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 05:28:16.182987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 05:28:16.183460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 05:28:16.183943) ========= ========= Total master_lag: 0.27 =========