builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1458949292.97 results: success (0) buildid: 20160325162215 builduid: 6d6e27ef101549e582ca1a7a674a44b6 revision: 5d52be560679db6df9c0db379d233ae86ba65aa8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:32.974783) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:32.975215) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:32.975500) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006348 basedir: '/builds/slave/test' ========= master_lag: 0.67 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:33.653652) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-25 16:41:33.653925) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-25 16:41:35.645847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:35.646111) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004679 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:35.703331) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:35.703597) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:35.703965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:35.704237) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-25 16:41:35-- 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% 223M=0s 2016-03-25 16:41:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.729341 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:36.445582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:36.448907) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017338 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:36.499306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-25 16:41:36.499657) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5d52be560679db6df9c0db379d233ae86ba65aa8 --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 5d52be560679db6df9c0db379d233ae86ba65aa8 --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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-25 16:41:36,811 truncating revision to first 12 chars 2016-03-25 16:41:36,811 Setting DEBUG logging. 2016-03-25 16:41:36,811 attempt 1/10 2016-03-25 16:41:36,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5d52be560679?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 16:41:39,034 unpacking tar archive at: fx-team-5d52be560679/testing/mozharness/ program finished with exit code 0 elapsedTime=2.685024 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-25 16:41:39.277098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:39.277398) ========= echo 5d52be560679db6df9c0db379d233ae86ba65aa8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5d52be560679db6df9c0db379d233ae86ba65aa8'] 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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5d52be560679db6df9c0db379d233ae86ba65aa8 program finished with exit code 0 elapsedTime=0.004636 script_repo_revision: '5d52be560679db6df9c0db379d233ae86ba65aa8' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:39.299250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:39.299536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 16:41:39.326664) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 56 secs) (at 2016-03-25 16:41:39.326985) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:41:39 INFO - MultiFileLogger online at 20160325 16:41:39 in /builds/slave/test 16:41:39 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 16:41:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:41:39 INFO - {'append_to_log': False, 16:41:39 INFO - 'base_work_dir': '/builds/slave/test', 16:41:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:41:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:41:39 INFO - 'branch': 'Fx-Team-Non-PGO', 16:41:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:41:39 INFO - 'config_files': ('talos/linux_config.py',), 16:41:39 INFO - 'default_actions': ('clobber', 16:41:39 INFO - 'read-buildbot-config', 16:41:39 INFO - 'download-and-extract', 16:41:39 INFO - 'populate-webroot', 16:41:39 INFO - 'create-virtualenv', 16:41:39 INFO - 'install', 16:41:39 INFO - 'run-tests'), 16:41:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:41:39 INFO - 'download_minidump_stackwalk': True, 16:41:39 INFO - 'download_symbols': 'ondemand', 16:41:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:41:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:41:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:41:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:41:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:41:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:41:39 INFO - 'installer_path': 'installer.exe', 16:41:39 INFO - 'log_level': 'info', 16:41:39 INFO - 'log_name': 'talos', 16:41:39 INFO - 'log_to_console': True, 16:41:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:41:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:41:39 INFO - 'opt_config_files': (), 16:41:39 INFO - 'pip_index': False, 16:41:39 INFO - 'sps_profile': False, 16:41:39 INFO - 'sps_profile_interval': 0, 16:41:39 INFO - 'suite': 'dromaeojs', 16:41:39 INFO - 'system_bits': '32', 16:41:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:41:39 INFO - 'title': 'talos-linux64-ix-034', 16:41:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:41:39 INFO - 'use_talos_json': True, 16:41:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:41:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:41:39 INFO - 'work_dir': 'build'} 16:41:39 INFO - ##### 16:41:39 INFO - ##### Running clobber step. 16:41:39 INFO - ##### 16:41:39 INFO - Running pre-action listener: _resource_record_pre_action 16:41:39 INFO - Running main action method: clobber 16:41:39 INFO - rmtree: /builds/slave/test/build 16:41:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:41:40 INFO - Running post-action listener: _resource_record_post_action 16:41:40 INFO - ##### 16:41:40 INFO - ##### Running read-buildbot-config step. 16:41:40 INFO - ##### 16:41:40 INFO - Running pre-action listener: _resource_record_pre_action 16:41:40 INFO - Running main action method: read_buildbot_config 16:41:40 INFO - Using buildbot properties: 16:41:40 INFO - { 16:41:40 INFO - "project": "", 16:41:40 INFO - "product": "firefox", 16:41:40 INFO - "script_repo_revision": "production", 16:41:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:41:40 INFO - "repository": "", 16:41:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:41:40 INFO - "buildid": "20160325162215", 16:41:40 INFO - "pgo_build": "False", 16:41:40 INFO - "basedir": "/builds/slave/test", 16:41:40 INFO - "buildnumber": 2698, 16:41:40 INFO - "slavename": "talos-linux64-ix-034", 16:41:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:41:40 INFO - "platform": "ubuntu64_hw", 16:41:40 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:41:40 INFO - "branch": "fx-team", 16:41:40 INFO - "repo_path": "integration/fx-team", 16:41:40 INFO - "revision": "5d52be560679db6df9c0db379d233ae86ba65aa8", 16:41:40 INFO - "stage_platform": "linux64", 16:41:40 INFO - "builduid": "6d6e27ef101549e582ca1a7a674a44b6", 16:41:40 INFO - "slavebuilddir": "test" 16:41:40 INFO - } 16:41:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:41:40 INFO - Running post-action listener: _resource_record_post_action 16:41:40 INFO - ##### 16:41:40 INFO - ##### Running download-and-extract step. 16:41:40 INFO - ##### 16:41:40 INFO - Running pre-action listener: _resource_record_pre_action 16:41:40 INFO - Running main action method: download_and_extract 16:41:40 INFO - mkdir: /builds/slave/test/build/tests 16:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:40 INFO - https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:41:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:41:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:41:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:41:45 INFO - Downloaded 1361 bytes. 16:41:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:41:45 INFO - Using the following test package requirements: 16:41:45 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:41:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:41:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:41:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:45 INFO - u'jsshell-linux-x86_64.zip'], 16:41:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:41:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:41:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:41:45 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:41:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:41:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:41:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:41:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:45 INFO - https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:41:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:41:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:41:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:41:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:42:28 INFO - Downloaded 22085846 bytes. 16:42:28 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'] 16:42:28 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 16:42:29 INFO - Return code: 0 16:42:29 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 16:42:29 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')]} 16:42:29 INFO - https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:42:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:42:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:42:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:42:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:43:05 INFO - Downloaded 22085846 bytes. 16:43:05 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'] 16:43:05 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 16:43:06 INFO - Return code: 0 16:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:06 INFO - https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:43:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:43:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:43:07 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:07 INFO - Running command: ['nslookup', u'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 16:43:07 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 16:43:07 INFO - Server: 10.26.75.40 16:43:07 INFO - Address: 10.26.75.40#53 16:43:07 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 16:43:07 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 16:43:07 INFO - Address: 10.26.48.46 16:43:07 INFO - Return code: 0 16:43:07 INFO - retry: attempt #1 caught exception: 16:43:07 INFO - retry: Failed, sleeping 30 seconds before retrying 16:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 #2 16:43:41 INFO - Downloaded 10847531 bytes. 16:43:41 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'] 16:43:41 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 16:43:41 INFO - Return code: 0 16:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:41 INFO - https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:43:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:43:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:43:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:43:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YtdZDWO4TZik4MSUBi2sfA/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 16:43:45 INFO - Downloaded 54260290 bytes. 16:43:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:43:45 INFO - mkdir: /builds/slave/test/properties 16:43:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:45 INFO - Contents: 16:43:45 INFO - build_url:https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:43:47 INFO - Running post-action listener: _resource_record_post_action 16:43:47 INFO - Running post-action listener: set_extra_try_arguments 16:43:47 INFO - ##### 16:43:47 INFO - ##### Running populate-webroot step. 16:43:47 INFO - ##### 16:43:47 INFO - Running pre-action listener: _resource_record_pre_action 16:43:47 INFO - Running main action method: populate_webroot 16:43:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:43:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:43:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:43:47 INFO - '--tppagecycles', 16:43:47 INFO - '7'], 16:43:47 INFO - 'tests': ['tsvgm']}}, 16:43:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:43:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:43:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:43:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:43:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:47 INFO - 'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:47 INFO - 'tests': ['damp', 'tps']}, 16:43:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:47 INFO - 'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['damp', 'tps']}, 16:43:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:43:47 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['dromaeo_dom']}, 16:43:47 INFO - 'other': {'tests': ['a11yr', 16:43:47 INFO - 'ts_paint', 16:43:47 INFO - 'tpaint', 16:43:47 INFO - 'sessionrestore', 16:43:47 INFO - 'sessionrestore_no_auto_restore', 16:43:47 INFO - 'tabpaint']}, 16:43:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['a11yr', 16:43:47 INFO - 'ts_paint', 16:43:47 INFO - 'tpaint', 16:43:47 INFO - 'sessionrestore', 16:43:47 INFO - 'sessionrestore_no_auto_restore', 16:43:47 INFO - 'tabpaint']}, 16:43:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['a11yr', 16:43:47 INFO - 'ts_paint', 16:43:47 INFO - 'tpaint', 16:43:47 INFO - 'sessionrestore', 16:43:47 INFO - 'sessionrestore_no_auto_restore', 16:43:47 INFO - 'tabpaint']}, 16:43:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['a11yr', 16:43:47 INFO - 'ts_paint', 16:43:47 INFO - 'tpaint', 16:43:47 INFO - 'sessionrestore', 16:43:47 INFO - 'sessionrestore_no_auto_restore', 16:43:47 INFO - 'tabpaint']}, 16:43:47 INFO - 'other_l64': {'tests': ['a11yr', 16:43:47 INFO - 'ts_paint', 16:43:47 INFO - 'tpaint', 16:43:47 INFO - 'sessionrestore', 16:43:47 INFO - 'sessionrestore_no_auto_restore', 16:43:47 INFO - 'tabpaint']}, 16:43:47 INFO - 'other_nol64': {'tests': ['a11yr', 16:43:47 INFO - 'ts_paint', 16:43:47 INFO - 'tpaint', 16:43:47 INFO - 'sessionrestore', 16:43:47 INFO - 'sessionrestore_no_auto_restore', 16:43:47 INFO - 'tabpaint']}, 16:43:47 INFO - 'svgr': {'tests': ['tsvgx', 16:43:47 INFO - 'tsvgr_opacity', 16:43:47 INFO - 'tart', 16:43:47 INFO - 'tscrollx', 16:43:47 INFO - 'cart']}, 16:43:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['tsvgx', 16:43:47 INFO - 'tsvgr_opacity', 16:43:47 INFO - 'tart', 16:43:47 INFO - 'tscrollx', 16:43:47 INFO - 'cart']}, 16:43:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:47 INFO - 'tests': ['tp5o']}, 16:43:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:47 INFO - 'talos_options': ['--e10s'], 16:43:47 INFO - 'tests': ['tp5o']}, 16:43:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:47 INFO - 'talos_options': ['--xperf_path', 16:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:47 INFO - 'tests': ['tp5n']}, 16:43:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:47 INFO - 'talos_options': ['--e10s', 16:43:47 INFO - '--xperf_path', 16:43:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:47 INFO - 'tests': ['tp5n']}}, 16:43:47 INFO - 'talos.zip': {'path': '', 16:43:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:43:47 INFO - Running post-action listener: _resource_record_post_action 16:43:47 INFO - ##### 16:43:47 INFO - ##### Running create-virtualenv step. 16:43:47 INFO - ##### 16:43:47 INFO - Running pre-action listener: _resource_record_pre_action 16:43:47 INFO - Running main action method: create_virtualenv 16:43:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:47 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 16:43:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:43:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:47 INFO - Using real prefix '/usr' 16:43:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:49 INFO - Installing pip.................done. 16:43:50 INFO - Return code: 0 16:43:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:43:50 INFO - Using env: {'DISPLAY': ':0', 16:43:50 INFO - 'HOME': '/home/cltbld', 16:43:50 INFO - 'LANG': 'en_US.UTF-8', 16:43:50 INFO - 'LANGUAGE': 'en_US:en', 16:43:50 INFO - 'LOGNAME': 'cltbld', 16:43:50 INFO - 'MAIL': '/var/mail/cltbld', 16:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:50 INFO - 'MOZ_NO_REMOTE': '1', 16:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:50 INFO - 'NO_EM_RESTART': '1', 16:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:50 INFO - 'PWD': '/builds/slave/test', 16:43:50 INFO - 'SHELL': '/bin/bash', 16:43:50 INFO - 'SHLVL': '1', 16:43:50 INFO - 'TERM': 'linux', 16:43:50 INFO - 'TMOUT': '86400', 16:43:50 INFO - 'USER': 'cltbld', 16:43:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:50 INFO - '_': '/tools/buildbot/bin/python'} 16:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:50 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 16:43:50 INFO - Cleaning up... 16:43:50 INFO - Return code: 0 16:43:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:43:50 INFO - Using env: {'DISPLAY': ':0', 16:43:50 INFO - 'HOME': '/home/cltbld', 16:43:50 INFO - 'LANG': 'en_US.UTF-8', 16:43:50 INFO - 'LANGUAGE': 'en_US:en', 16:43:50 INFO - 'LOGNAME': 'cltbld', 16:43:50 INFO - 'MAIL': '/var/mail/cltbld', 16:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:50 INFO - 'MOZ_NO_REMOTE': '1', 16:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:50 INFO - 'NO_EM_RESTART': '1', 16:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:50 INFO - 'PWD': '/builds/slave/test', 16:43:50 INFO - 'SHELL': '/bin/bash', 16:43:50 INFO - 'SHLVL': '1', 16:43:50 INFO - 'TERM': 'linux', 16:43:50 INFO - 'TMOUT': '86400', 16:43:50 INFO - 'USER': 'cltbld', 16:43:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:50 INFO - '_': '/tools/buildbot/bin/python'} 16:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:50 INFO - Downloading/unpacking psutil>=0.7.1 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:43:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:55 INFO - Installing collected packages: psutil 16:43:55 INFO - Running setup.py install for psutil 16:43:55 INFO - building 'psutil._psutil_linux' extension 16:43:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:43:56 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 16:43:56 INFO - building 'psutil._psutil_posix' extension 16:43:56 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 16:43:56 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 16:43:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:56 INFO - Successfully installed psutil 16:43:56 INFO - Cleaning up... 16:43:56 INFO - Return code: 0 16:43:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:56 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 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:43:56 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 16:43:56 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 16:43:56 INFO - Using env: {'DISPLAY': ':0', 16:43:56 INFO - 'HOME': '/home/cltbld', 16:43:56 INFO - 'LANG': 'en_US.UTF-8', 16:43:56 INFO - 'LANGUAGE': 'en_US:en', 16:43:56 INFO - 'LOGNAME': 'cltbld', 16:43:56 INFO - 'MAIL': '/var/mail/cltbld', 16:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:56 INFO - 'MOZ_NO_REMOTE': '1', 16:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:56 INFO - 'NO_EM_RESTART': '1', 16:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:56 INFO - 'PWD': '/builds/slave/test', 16:43:56 INFO - 'SHELL': '/bin/bash', 16:43:56 INFO - 'SHLVL': '1', 16:43:56 INFO - 'TERM': 'linux', 16:43:56 INFO - 'TMOUT': '86400', 16:43:56 INFO - 'USER': 'cltbld', 16:43:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:56 INFO - '_': '/tools/buildbot/bin/python'} 16:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:43:56 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 16:43:56 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 16:43:56 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 16:43:56 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 16:43:56 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 16:43:56 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 16:44:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44: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) 16:44:00 INFO - Installing collected packages: mozsystemmonitor 16:44:00 INFO - Running setup.py install for mozsystemmonitor 16:44:00 INFO - Successfully installed mozsystemmonitor 16:44:00 INFO - Cleaning up... 16:44:00 INFO - Return code: 0 16:44:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:44: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 16:44: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 16:44:00 INFO - Using env: {'DISPLAY': ':0', 16:44:00 INFO - 'HOME': '/home/cltbld', 16:44:00 INFO - 'LANG': 'en_US.UTF-8', 16:44:00 INFO - 'LANGUAGE': 'en_US:en', 16:44:00 INFO - 'LOGNAME': 'cltbld', 16:44:00 INFO - 'MAIL': '/var/mail/cltbld', 16:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:00 INFO - 'MOZ_NO_REMOTE': '1', 16:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:00 INFO - 'NO_EM_RESTART': '1', 16:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:00 INFO - 'PWD': '/builds/slave/test', 16:44:00 INFO - 'SHELL': '/bin/bash', 16:44:00 INFO - 'SHLVL': '1', 16:44:00 INFO - 'TERM': 'linux', 16:44:00 INFO - 'TMOUT': '86400', 16:44:00 INFO - 'USER': 'cltbld', 16:44:00 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:00 INFO - '_': '/tools/buildbot/bin/python'} 16:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:01 INFO - Downloading/unpacking blobuploader==1.2.4 16:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:07 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:08 INFO - Downloading docopt-0.6.1.tar.gz 16:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:08 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:08 INFO - Running setup.py install for blobuploader 16:44:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:08 INFO - Running setup.py install for requests 16:44:09 INFO - Running setup.py install for docopt 16:44:09 INFO - Successfully installed blobuploader requests docopt 16:44:09 INFO - Cleaning up... 16:44:09 INFO - Return code: 0 16:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:09 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')]} 16:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:09 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')]} 16:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:09 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 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:44:09 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 16:44:09 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 16:44:09 INFO - Using env: {'DISPLAY': ':0', 16:44:09 INFO - 'HOME': '/home/cltbld', 16:44:09 INFO - 'LANG': 'en_US.UTF-8', 16:44:09 INFO - 'LANGUAGE': 'en_US:en', 16:44:09 INFO - 'LOGNAME': 'cltbld', 16:44:09 INFO - 'MAIL': '/var/mail/cltbld', 16:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:09 INFO - 'MOZ_NO_REMOTE': '1', 16:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:09 INFO - 'NO_EM_RESTART': '1', 16:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:09 INFO - 'PWD': '/builds/slave/test', 16:44:09 INFO - 'SHELL': '/bin/bash', 16:44:09 INFO - 'SHLVL': '1', 16:44:09 INFO - 'TERM': 'linux', 16:44:09 INFO - 'TMOUT': '86400', 16:44:09 INFO - 'USER': 'cltbld', 16:44:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:09 INFO - '_': '/tools/buildbot/bin/python'} 16:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:09 INFO - Running setup.py (path:/tmp/pip-VizbW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:09 INFO - Running setup.py (path:/tmp/pip-5dHPD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:09 INFO - Running setup.py (path:/tmp/pip-Tgt7Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:09 INFO - Running setup.py (path:/tmp/pip-RH_etN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:09 INFO - Running setup.py (path:/tmp/pip-pl9nUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:09 INFO - Running setup.py (path:/tmp/pip-L92P0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:10 INFO - Running setup.py (path:/tmp/pip-i2BPu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:10 INFO - Running setup.py (path:/tmp/pip-49IQWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:10 INFO - Running setup.py (path:/tmp/pip-7AzsUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:10 INFO - Running setup.py (path:/tmp/pip-4efcGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:10 INFO - Running setup.py (path:/tmp/pip-X4ruMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:10 INFO - Running setup.py (path:/tmp/pip-RxxUyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:10 INFO - Running setup.py (path:/tmp/pip-Zm1SYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:10 INFO - Running setup.py (path:/tmp/pip-ldeIPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:10 INFO - Running setup.py (path:/tmp/pip-NYXRgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:10 INFO - Running setup.py (path:/tmp/pip-Jp_7s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:10 INFO - Running setup.py (path:/tmp/pip-_RQ06e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:10 INFO - Running setup.py install for manifestparser 16:44:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:10 INFO - Running setup.py install for mozcrash 16:44:11 INFO - Running setup.py install for mozdebug 16:44:11 INFO - Running setup.py install for mozdevice 16:44:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozfile 16:44:11 INFO - Running setup.py install for mozhttpd 16:44:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozinfo 16:44:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozInstall 16:44:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozleak 16:44:11 INFO - Running setup.py install for mozlog 16:44:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for moznetwork 16:44:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:11 INFO - Running setup.py install for mozprocess 16:44:12 INFO - Running setup.py install for mozprofile 16:44:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Running setup.py install for mozrunner 16:44:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Running setup.py install for mozscreenshot 16:44:12 INFO - Running setup.py install for moztest 16:44:12 INFO - Running setup.py install for mozversion 16:44:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:12 INFO - Cleaning up... 16:44:12 INFO - Return code: 0 16:44:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:12 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')]} 16:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:12 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')]} 16:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:12 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 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:44:12 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 16:44:12 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 16:44:12 INFO - Using env: {'DISPLAY': ':0', 16:44:12 INFO - 'HOME': '/home/cltbld', 16:44:12 INFO - 'LANG': 'en_US.UTF-8', 16:44:12 INFO - 'LANGUAGE': 'en_US:en', 16:44:12 INFO - 'LOGNAME': 'cltbld', 16:44:12 INFO - 'MAIL': '/var/mail/cltbld', 16:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:12 INFO - 'MOZ_NO_REMOTE': '1', 16:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:12 INFO - 'NO_EM_RESTART': '1', 16:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:12 INFO - 'PWD': '/builds/slave/test', 16:44:12 INFO - 'SHELL': '/bin/bash', 16:44:12 INFO - 'SHLVL': '1', 16:44:12 INFO - 'TERM': 'linux', 16:44:12 INFO - 'TMOUT': '86400', 16:44:12 INFO - 'USER': 'cltbld', 16:44:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:12 INFO - '_': '/tools/buildbot/bin/python'} 16:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:12 INFO - Running setup.py (path:/tmp/pip-zZs3FM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:12 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)) 16:44:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:12 INFO - Running setup.py (path:/tmp/pip-TaNZlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:13 INFO - Running setup.py (path:/tmp/pip-0RLJtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:13 INFO - Running setup.py (path:/tmp/pip-7xpcwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:13 INFO - Running setup.py (path:/tmp/pip-NTaSDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:13 INFO - Running setup.py (path:/tmp/pip-LfNbbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:13 INFO - Running setup.py (path:/tmp/pip-pedXBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:13 INFO - Running setup.py (path:/tmp/pip-kWH7jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:13 INFO - Running setup.py (path:/tmp/pip-fz1hIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:13 INFO - Running setup.py (path:/tmp/pip-cTLmLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:13 INFO - Running setup.py (path:/tmp/pip-8tfrzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:13 INFO - Running setup.py (path:/tmp/pip-CPSQk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:13 INFO - Running setup.py (path:/tmp/pip-_B6g42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:13 INFO - Running setup.py (path:/tmp/pip-yTeZTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:13 INFO - Running setup.py (path:/tmp/pip-A7KaSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:13 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)) 16:44:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:13 INFO - Running setup.py (path:/tmp/pip-IGOpYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:14 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)) 16:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:14 INFO - Running setup.py (path:/tmp/pip-qrtQM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:14 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)) 16:44:14 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)) 16:44:14 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)) 16:44:14 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)) 16:44:14 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)) 16:44:14 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)) 16:44:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:18 INFO - Downloading blessings-1.6.tar.gz 16:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:18 INFO - Installing collected packages: blessings 16:44:18 INFO - Running setup.py install for blessings 16:44:18 INFO - Successfully installed blessings 16:44:18 INFO - Cleaning up... 16:44:18 INFO - Return code: 0 16:44:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:18 INFO - Reading from file tmpfile_stdout 16:44:18 INFO - Current package versions: 16:44:18 INFO - argparse == 1.2.1 16:44:18 INFO - blessings == 1.6 16:44:18 INFO - blobuploader == 1.2.4 16:44:18 INFO - docopt == 0.6.1 16:44:18 INFO - manifestparser == 1.1 16:44:18 INFO - mozInstall == 1.12 16:44:18 INFO - mozcrash == 0.17 16:44:18 INFO - mozdebug == 0.1 16:44:18 INFO - mozdevice == 0.48 16:44:18 INFO - mozfile == 1.2 16:44:18 INFO - mozhttpd == 0.7 16:44:18 INFO - mozinfo == 0.9 16:44:18 INFO - mozleak == 0.1 16:44:18 INFO - mozlog == 3.1 16:44:18 INFO - moznetwork == 0.27 16:44:18 INFO - mozprocess == 0.22 16:44:18 INFO - mozprofile == 0.28 16:44:18 INFO - mozrunner == 6.11 16:44:18 INFO - mozscreenshot == 0.1 16:44:18 INFO - mozsystemmonitor == 0.0 16:44:18 INFO - moztest == 0.7 16:44:18 INFO - mozversion == 1.4 16:44:18 INFO - psutil == 3.1.1 16:44:18 INFO - requests == 1.2.3 16:44:18 INFO - wsgiref == 0.1.2 16:44:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:18 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')]} 16:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:18 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')]} 16:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:18 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 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:44:18 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 16:44:18 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 16:44:18 INFO - Using env: {'DISPLAY': ':0', 16:44:18 INFO - 'HOME': '/home/cltbld', 16:44:18 INFO - 'LANG': 'en_US.UTF-8', 16:44:18 INFO - 'LANGUAGE': 'en_US:en', 16:44:18 INFO - 'LOGNAME': 'cltbld', 16:44:18 INFO - 'MAIL': '/var/mail/cltbld', 16:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:18 INFO - 'MOZ_NO_REMOTE': '1', 16:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:18 INFO - 'NO_EM_RESTART': '1', 16:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:18 INFO - 'PWD': '/builds/slave/test', 16:44:18 INFO - 'SHELL': '/bin/bash', 16:44:18 INFO - 'SHLVL': '1', 16:44:18 INFO - 'TERM': 'linux', 16:44:18 INFO - 'TMOUT': '86400', 16:44:18 INFO - 'USER': 'cltbld', 16:44:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:18 INFO - '_': '/tools/buildbot/bin/python'} 16:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 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)) 16:44:18 INFO - Cleaning up... 16:44:18 INFO - Return code: 0 16:44:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:18 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')]} 16:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:18 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')]} 16:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:18 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 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:44:18 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 16:44:18 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 16:44:18 INFO - Using env: {'DISPLAY': ':0', 16:44:18 INFO - 'HOME': '/home/cltbld', 16:44:18 INFO - 'LANG': 'en_US.UTF-8', 16:44:18 INFO - 'LANGUAGE': 'en_US:en', 16:44:18 INFO - 'LOGNAME': 'cltbld', 16:44:18 INFO - 'MAIL': '/var/mail/cltbld', 16:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:18 INFO - 'MOZ_NO_REMOTE': '1', 16:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:18 INFO - 'NO_EM_RESTART': '1', 16:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:18 INFO - 'PWD': '/builds/slave/test', 16:44:18 INFO - 'SHELL': '/bin/bash', 16:44:18 INFO - 'SHLVL': '1', 16:44:18 INFO - 'TERM': 'linux', 16:44:18 INFO - 'TMOUT': '86400', 16:44:18 INFO - 'USER': 'cltbld', 16:44:18 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:18 INFO - '_': '/tools/buildbot/bin/python'} 16:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:19 INFO - Downloading/unpacking jsonschema 16:44:19 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 16:44:19 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 16:44:19 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 16:44:19 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 16:44:19 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 16:44:19 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 16:44:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:44:22 INFO - Downloading/unpacking functools32 (from jsonschema) 16:44:22 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 16:44:22 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 16:44:22 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 16:44:22 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 16:44:22 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 16:44:22 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 16:44:22 INFO - Downloading functools32-3.2.3-2.tar.gz 16:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:44:23 INFO - warning: no files found matching '*.txt' 16:44:23 INFO - no previously-included directories found matching 'build' 16:44:23 INFO - no previously-included directories found matching 'dist' 16:44:23 INFO - no previously-included directories found matching '.git*' 16:44:23 INFO - Installing collected packages: jsonschema, functools32 16:44:23 INFO - Running setup.py install for functools32 16:44:23 INFO - warning: no files found matching '*.txt' 16:44:23 INFO - no previously-included directories found matching 'build' 16:44:23 INFO - no previously-included directories found matching 'dist' 16:44:23 INFO - no previously-included directories found matching '.git*' 16:44:23 INFO - Successfully installed jsonschema functools32 16:44:23 INFO - Cleaning up... 16:44:23 INFO - Return code: 0 16:44:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:23 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 0x7fec78daff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', '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 16:44:23 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 16:44:23 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 16:44:23 INFO - Using env: {'DISPLAY': ':0', 16:44:23 INFO - 'HOME': '/home/cltbld', 16:44:23 INFO - 'LANG': 'en_US.UTF-8', 16:44:23 INFO - 'LANGUAGE': 'en_US:en', 16:44:23 INFO - 'LOGNAME': 'cltbld', 16:44:23 INFO - 'MAIL': '/var/mail/cltbld', 16:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:23 INFO - 'MOZ_NO_REMOTE': '1', 16:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:23 INFO - 'NO_EM_RESTART': '1', 16:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:23 INFO - 'PWD': '/builds/slave/test', 16:44:23 INFO - 'SHELL': '/bin/bash', 16:44:23 INFO - 'SHLVL': '1', 16:44:23 INFO - 'TERM': 'linux', 16:44:23 INFO - 'TMOUT': '86400', 16:44:23 INFO - 'USER': 'cltbld', 16:44:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:23 INFO - '_': '/tools/buildbot/bin/python'} 16:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:23 INFO - Downloading/unpacking flake8 16:44:23 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 16:44:23 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 16:44:23 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 16:44:23 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 16:44:23 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 16:44:23 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 16:44:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:44:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:44:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:34 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 16:44:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:44:35 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 16:44:35 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 16:44:35 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 16:44:35 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 16:44:35 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 16:44:35 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 16:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:44:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:35 INFO - no previously-included directories found matching 'docs/_build' 16:44:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:44:35 INFO - Running setup.py install for pep8 16:44:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:35 INFO - no previously-included directories found matching 'docs/_build' 16:44:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:44:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:44:35 INFO - Cleaning up... 16:44:35 INFO - Return code: 0 16:44:35 INFO - Running post-action listener: _resource_record_post_action 16:44:35 INFO - Running post-action listener: _start_resource_monitoring 16:44:35 INFO - Starting resource monitoring. 16:44:35 INFO - ##### 16:44:35 INFO - ##### Running install step. 16:44:35 INFO - ##### 16:44:35 INFO - Running pre-action listener: _resource_record_pre_action 16:44:35 INFO - Running main action method: install 16:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:36 INFO - Reading from file tmpfile_stdout 16:44:36 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:36 INFO - Reading from file tmpfile_stdout 16:44:36 INFO - Output received: 16:44:36 INFO - Usage: mozinstall [options] installer 16:44:36 INFO - Options: 16:44:36 INFO - -h, --help show this help message and exit 16:44:36 INFO - -d DEST, --destination=DEST 16:44:36 INFO - Directory to install application into. [default: 16:44:36 INFO - "/builds/slave/test"] 16:44:36 INFO - --app=APP Application being installed. [default: firefox] 16:44:36 INFO - mkdir: /builds/slave/test/build/application 16:44:36 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'] 16:44:36 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 16:44:51 INFO - Reading from file tmpfile_stdout 16:44:51 INFO - Output received: 16:44:51 INFO - /builds/slave/test/build/application/firefox/firefox 16:44:51 INFO - Running post-action listener: _resource_record_post_action 16:44:51 INFO - ##### 16:44:51 INFO - ##### Running run-tests step. 16:44:51 INFO - ##### 16:44:51 INFO - Running pre-action listener: _resource_record_pre_action 16:44:51 INFO - Running main action method: run_tests 16:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:44:51 INFO - Python 2.7.3 16:44:51 INFO - Return code: 0 16:44:51 INFO - grabbing minidump binary from tooltool 16:44:51 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')]} 16:44:51 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 0x2b7e410>, '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 0x2b7f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:44:51 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 16:44:51 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 16:44:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:51 INFO - Return code: 0 16:44:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:44:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:44:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:44:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:44:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:44:52 INFO - Return code: 0 16:44:52 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/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 16:44:52 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/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 16:44:52 INFO - Using env: {'DISPLAY': ':0', 16:44:52 INFO - 'HOME': '/home/cltbld', 16:44:52 INFO - 'LANG': 'en_US.UTF-8', 16:44:52 INFO - 'LANGUAGE': 'en_US:en', 16:44:52 INFO - 'LOGNAME': 'cltbld', 16:44:52 INFO - 'MAIL': '/var/mail/cltbld', 16:44:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:52 INFO - 'MOZ_NO_REMOTE': '1', 16:44:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:52 INFO - 'NO_EM_RESTART': '1', 16:44:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:52 INFO - 'PWD': '/builds/slave/test', 16:44:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:52 INFO - 'SHELL': '/bin/bash', 16:44:52 INFO - 'SHLVL': '1', 16:44:52 INFO - 'TERM': 'linux', 16:44:52 INFO - 'TMOUT': '86400', 16:44:52 INFO - 'USER': 'cltbld', 16:44:52 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761', 16:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:52 INFO - '_': '/tools/buildbot/bin/python'} 16:44:52 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/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 16:44:53 INFO - mozversion application_buildid: 20160325162215 16:44:53 INFO - mozversion application_changeset: 5d52be560679db6df9c0db379d233ae86ba65aa8 16:44:53 INFO - mozversion application_display_name: Nightly 16:44:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:53 INFO - mozversion application_name: Firefox 16:44:53 INFO - mozversion application_remotingname: firefox 16:44:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:44:53 INFO - mozversion application_vendor: Mozilla 16:44:53 INFO - mozversion application_version: 48.0a1 16:44:53 INFO - mozversion platform_buildid: 20160325162215 16:44:53 INFO - mozversion platform_changeset: 5d52be560679db6df9c0db379d233ae86ba65aa8 16:44:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:44:53 INFO - mozversion platform_version: 48.0a1 16:44:53 INFO - using testdate: 1458949493 16:44:53 INFO - actual date: 1458949493 16:44:53 INFO - starting webserver on 'localhost:54025' 16:44:53 INFO - SUITE-START | Running 2 tests 16:44:53 INFO - TEST-START | dromaeo_css 16:44:53 INFO - operating with platform_type : linux_ 16:44:53 INFO - Initialising browser for dromaeo_css test... 16:44:53 INFO - TEST-INFO | started process 18365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNFTsKV/profile http://localhost:54025/getInfo.html) 16:44:57 INFO - PROCESS | 18365 | __metrics Screen width/height:1600/1200 16:44:57 INFO - PROCESS | 18365 | colorDepth:24 16:44:57 INFO - PROCESS | 18365 | Browser inner width/height: 1024/697 16:44:57 INFO - PROCESS | 18365 | __metrics 16:44:58 ERROR - PROCESS | 18365 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:44:59 INFO - TEST-INFO | 18365: exit 0 16:44:59 INFO - Browser initialized. 16:44:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:44:59 INFO - TEST-INFO | started process 18460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNFTsKV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:11 INFO - PROCESS | 18460 | RSS: Main: 154980352 16:45:11 INFO - PROCESS | 18460 | 16:46:02 INFO - PROCESS | 18460 | 1458949562266 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] 16:48:14 INFO - PROCESS | 18460 | Cycle 1(1): loaded http://localhost:54025/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54025/tests/dromaeo/cssquery-ext.html) 16:48:15 INFO - PROCESS | 18460 | RSS: Main: 268816384 16:48:15 INFO - PROCESS | 18460 | 16:51:17 INFO - PROCESS | 18460 | Cycle 1(1): loaded http://localhost:54025/tests/dromaeo/cssquery-ext.html (next: http://localhost:54025/tests/dromaeo/cssquery-jquery.html) 16:51:18 INFO - PROCESS | 18460 | RSS: Main: 244609024 16:51:18 INFO - PROCESS | 18460 | 16:54:20 INFO - PROCESS | 18460 | Cycle 1(1): loaded http://localhost:54025/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54025/tests/dromaeo/cssquery-mootools.html) 16:54:20 INFO - PROCESS | 18460 | RSS: Main: 235520000 16:54:20 INFO - PROCESS | 18460 | 16:57:22 INFO - PROCESS | 18460 | Cycle 1(1): loaded http://localhost:54025/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54025/tests/dromaeo/cssquery-prototype.html) 16:57:23 INFO - PROCESS | 18460 | RSS: Main: 224309248 16:57:23 INFO - PROCESS | 18460 | 17:00:26 INFO - PROCESS | 18460 | Cycle 1(1): loaded http://localhost:54025/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54025/tests/dromaeo/cssquery-yui.html) 17:00:26 INFO - PROCESS | 18460 | RSS: Main: 202412032 17:00:26 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | Cycle 1(1): loaded http://localhost:54025/tests/dromaeo/cssquery-yui.html (next: http://localhost:54025/tests/dromaeo/cssquery-dojo.html) 17:03:29 INFO - PROCESS | 18460 | RSS: Main: 300838912 17:03:29 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | __start_tp_report 17:03:29 INFO - PROCESS | 18460 | _x_x_mozilla_page_load 17:03:29 INFO - PROCESS | 18460 | _x_x_mozilla_page_load_details 17:03:29 INFO - PROCESS | 18460 | |i|pagename|runs| 17:03:29 INFO - PROCESS | 18460 | |0;dojo.html;2605.8697065146744;2666.1601595497405;2670.550863256064;2683.6511253537024;2705.9729402705975;4572.634189264859;4575.130725162217;4586.678932474724;4589.311603259504;4685.109829132462;4612.723236605806;4620.907581848361;4648.442186937572;4682.274247491636;4685.3206285088645;4207.9789601052025;4229.577042295761;4261.744295342274;4293;4391.802368893392;4319.157764235975;4350.347447882811;4355.368471571636;4397.230484665187;4402.625776808975;4180.519240287345;4220.78896055199;4260.297050986584;4291.57084291573;4294.720843145185;4255.8084886180195;4266.189424009459;4300.182965236595;4308.267594508941;4315.201687687788;4231.957680423187;4242.215190189794;4252.596003379674;4265.402843601898;4280.892977675552;4473.888152796206;4538.137753826795;4540.568645978627;4569.588737013684;4623.42207224097;4938.827141050046;4944.258361245842;4946.307516947594;4947.727874966876;4965.329680493123;4951.232558953368;4953.702777833341;4960.677555958887;4963.950360496385;5009.699418034893;4558.133954548625;4624.028953919647;4635.605973492257;4709.458412282632;4710.717356958594;5036.647434679538;5058.291839142523;5059.342285502935;5059.747012649353;5095.490450954875;4866.513348665105;4868.391451068616;4868.537488938545;4912.214045752662;4912.901741965141;4790.041991601694;4900.509949005071;4934.1118598651865;4974.030064137531;4980.526849949249;4914.533119353727;4926.285688575136;4936.901261974812;4937.950620493749;4990.426100998359;4933.45731969483;4937.925931111036;4939.654224204343;4945.109880221523;4987.451380348159;4132.5454200037975;4161.417401563784;4178.979105104455;4192.266353388145;4218.894527636834;3679.6504332088407;3697.315996540595;3703.814809259526;3709.2581483703366;3726;4262.744235345889;4263.126059157865;4265.317549192115;4296.033392486728;4309.418228539107;4903;4938.925916111261;4964.354633897642;5064.924026139611;5065.544101030851;4277.636400905958;4282.614564689193;4285.121550082225;4285.335772955197;4329.783510824446;4447.421835161408;4477.440319960005;4479.932801007987;4520.683552151384;4525.728456292633;4555.567221113989;4634.9536504634525;4685.461171965268;4713.6936099153445;4734.928976065293;4923.261510773413;4930.704157750546;4940.431850337257;4950.257461380822;4975.577075948585;4615;4666.323383109362;4673.953260467351;4674.953250467452;4717.716936983792;4870.78081486341;4886.047220792054;4889.291052797395;4935.136351138464;4941.085899108676;4931.50684931504;4961.875953101201;4963.627727920492;4970.080535101018;5011.072951503984;4690.413698287714;4816.446108697404;4826.131296366547;4835.637327200404;4867.683600565952;4810.5670489656095;4833.347498087714;4844.491328410466;4845;4887.36464259644;4756.120117778222;4756.6908150970075;4760.595349395202;4764.094821983812;4800.73595952226;4726.692764970266;4793.9280910785665;4843.2735089736825;4893.828715994923;4902.901941961212;4653.139169253699;4689.437267527918;4725.5510726480925;4733.053389322081;4744.051189761993 17:03:29 INFO - PROCESS | 18460 | |1;ext.html;526.8709166254266;531.5853634165351;542.5713686187912;552.4999875113024;558.3969313141806;27002.864985675067;34533.82733086337;35075.473867892004;35140;35201.00791432731;36946;37554;37573.11549498568;37601.247975040555;37609.24781504368;7609.124950630693;7776.222377762235;7783.494072885244;7784.377249820029;7790.532568045907;7652.693892244303;7675.270849269338;7721.420893432987;7745.535267883917;7775.883361749578;7726.188750181234;7980.082290536576;7992.840143197132;7997.680092796281;8001.479903806234;7875.606219689022;7919.089304729972;7942.801429964239;7948.682052717884;7954.522728636301;7750.689972401097;7860.646270917822;7874.5668988205625;7878.527288362717;7878.645460954271;38044;38249.426258606145;38387.8080609598;38403.231935361415;38428.23143537142;3109.238236632017;3194.37709646619;3217.2921957169387;3228.7739858209934;3604.4953706481115;28366.574501382496;28477.85761071202;29068.563971540232;29185.270368240963;29237.122886313446;3355.697987181141;3379.2734562069027;3383.2725963917874;3421.5209870618132;3437.089171369589;231517;234488;234614;234842;235451;48926;53248.46751532512;53730.7313463438;54090.72954635201;57274.42725572691;51582.74208628933;51889.2216616751;51911.74044129755;51931.22103168455;52024;13689.726205475834;13822.308884555732;13884.652883677787;13911.30443477822;13925.651858703613;9342.90657093434;10448.634297799541;10487;10632.734181645521;10904;18369.908150459163;18606.906965465358;18673;18696.626067478846;18726.157322920502;6906.240313565504;7234.529755565872;7251.92748072523;7307.2327405621645;7367.5211111277595;925.9120383563551;944.9558238146749;956.0821611253275;960.846264597661;1036.79782442423;26354.20937371882;27150.45699086007;27847.72152278492;27858.442831143264;27883.581746273823;961.8893827209821;995.7411073121041;1023.4371095897227;1025.395016939994;1057.9947100264449;14030.929845350707;14357.78463323051;14542.4910128145;14567.271636418349;14712.33794479251;274736;278213;278382;278572;278606;45865.770671146434;46825;46838;46941.530584694396;47040.76479617648;1067.631667074858;1172.6775136837268;1184.283508477376;1224.4489979509078;1252.5490823303603;24221.63667544953;26055.218343449727;26878.32804179911;27069.323266918484;27316.180514584594;35407;35700.64299356973;36117.27765444624;36970.8151459241;37011.259774804894;167512;177402;179093.1045344765;179212;179511;26609.467810644066;30405.695943040286;30675.318961724737;30714.692853071185;30729.231769205053;34985.30029399347;38270.80864595659;38329.80835095807;39044.41433378445;39108.41337379999;32992.67007329896;33128.52150524257;33308.50037249492;33955.83022084874;34066;32618.021459356256;32828.17929551685;33088;33292.833535832164;33497;32772.50841237431;32793.67206327906;32880.67119328872;33076.338473230884;33259.667403326624;28259.858700706365;29535;29694.406111877208;29802.85098574493;29865.200107600176;23292.883535582212;23447.51071974686;23761;23963.640545392183;24104.87947560251 17:03:29 INFO - PROCESS | 18460 | |2;jquery.html;340.10382641739017;349.3850822552307;357.039563573986;358.9784612923225;362.26835725233394;15398.846011539881;15853.048817070983;15902.76145857813;16607.584810379747;16610.83389166108;10269.22980776441;10485.475726213697;10715.732106697316;10880.455977201147;10889.83665245022;4578.999999999992;4699.248120300753;4705.435347758274;4721.055788842228;4727.716337019772;3442.4664177052596;5113.744312784364;5329.920051199235;5377.327834020747;5381.919271210935;5406.053940560406;5410.161424979135;5420.159875219328;5420.403755586883;5446.863828404302;5219.686818790885;5361.892762144755;5373.113436283009;5413.133898576229;5413.783448662069;5108.106081435734;5133.050385678662;5151.098557752378;5172.017316709813;5176.171812509981;12107.697307567294;19134;19300.552458565522;19663.213471461266;19677.409677709693;1923.9422817315503;2246.7865552772623;2422.880104235562;2458.741832107639;2458.987705061463;9032.54837258141;9080.318976076755;9320.627174912996;9451.480168590724;9536.046395360478;1768.3633891798943;1773.485689150145;1773.5211492896847;1788.3740690758261;1811.7644706188244;60491.69754151201;62993.685031575005;63275.6836215816;63613.36386636121;63698.681506592635;9471.952640236892;9587.280953928483;9595.664151754794;9625.422474651543;9665.178459830853;13151.671208219872;13250;13253.403596838165;13260.933695331461;13293.601191964257;7008.439324853999;7065.258147894397;7081.362677358959;7139.357457828821;7164.749233776793;6641.501887358468;6777.322267773282;6816.931830681629;6841.281665425158;6885.931140688629;4121.4848143982;4231.894202644959;4261.616454519108;4292.077203401222;4310.792977966112;1607.6704275623704;1681.3946979087518;1752.281564558525;1762.3038899634828;1766.3994241957796;832.8334333133398;869.8347314010318;872.1148034744739;893.7497500699815;898.8651702244715;14868.182249976138;15827.841721582638;16073.517794466185;16388.6722265554;16536.421225257058;868.3313848336871;871.4988881393224;891.4562117108559;955.7306739088538;979.0943377375899;9011.459312441275;9329.16037556623;9458.716238512718;9463.668771592962;9518.825323723811;351662;353765;373870;380799;386654;67317.66341168263;67544.66227668831;68945.31054689489;71511;72557.91163132557;911.1344222988188;929.0477260807592;934.289939645874;934.6261495401893;936.1340759797297;14494.565163045125;14547.910376609283;14601.561953141423;14746.705065898408;15044.247787610357;32397.67602324041;32533.34933301368;32595.348093037534;32698.182545436553;33294.5005824908;42356.788216058725;45606.08787824291;45907;46096.07807843891;46506.53493465022;7551.660175292015;7576.1287451941525;7680.155182929985;7715.267049630276;7829.256220659028;8600.78498037554;10338.741531461774;11222.88777112251;11483.712907177052;11864;9853.802923941337;9900.158486528726;9939.900600994186;9973.45146016947;10144.746381340525;10034.749131271778;10391.324563903323;10506.579736810747;10615.628453004108;10686.839697404701;10530.262881598215;10592.682219533426;10682.916831217837;10693;10776.622818201326;7432.554046757212;7599.544027358376;7648.579328137006;7677.731279405194;7723.420743444151;7733.994580704698;9480.146786788946;9540.713778586654;9716.368436051634;10126.746831329276 17:03:29 INFO - PROCESS | 18460 | |3;mootools.html;1308.6139588821297;1445.306252998561;1481.95554133376;1643.038822288961;1794.6500432415676;7281.199068102511;7485.588292643909;7503.512271702336;7512.173660897311;7526.586037767921;7308.086489188851;7490.737824176155;7506.061742282215;7509.173990861001;7509.361704255145;1923.1153669312134;1968.0258272155231;1970.7339509166222;2266.9433264168447;2289.416198869286;2249.80876625487;2313.53729254149;2316.050419328076;2319.2694301295123;2319.4433335999324;2227.732672079345;2260.389694782408;2271.681964524968;2272.8522646028036;2274.2267629006133;2254.391314345134;2270.5345404192103;2271.522980174157;2279.943001424969;2281.9657705134437;2267.6258417361114;2270.8069814065825;2272.4432514034165;2288.473651060249;2297.356740112771;7535.321821036133;7564.848703025964;7572.583507907063;7577.696892124309;7600.391968642495;4731.384919960383;4845.563899249085;4870.512948705136;4878.121938051149;4896.608271338285;3029.091272618206;3054.5112781955004;3209.646938836726;3248.4964830451318;3263.5594194783876;1055.625253035177;1067.5889782433742;1741.939032133882;1751.6846967545837;1789.5615574184408;10217.642382516651;10294.3823370598;10366.792664146675;10374.740631484274;10385;4069.4709687740406;4179.916401672011;4213.620774130343;4260.084081922401;4263.850765223202;8344.08215096339;8367.372447066495;8376.706815261437;8399.832003360021;8402.243798058082;4749.572538471485;4774.379330686988;4780.163471392562;4795.880102997453;4801.375821143229;3782.3569993101237;4195.727277726938;4341.565843415697;4433.933490997638;4446.199684056901;3394.253264281854;3404.5914490261325;3457.896263112111;3480.63453337401;3481.7910925344054;1032.829583118792;1061.5223149582564;1063.9095676867553;1072.2601405030505;1074.2748644664975;1169.8771628979005;1181.8313394920417;1203.5125774061519;1209.0327737809716;1217.738186289952;7104.467164962649;7250.709971601183;7273.418126549864;7274.454415918827;7328.560286382834;446.37730366139056;453.31549360465937;457.9015511665008;458.550620392011;459.91951408503377;5589.357223919302;5652.095664693629;5652.519535839418;5654.180143879114;5679.602427830095;9262.95368523153;9393.5303234838;9603.279754018477;9615.615375385047;9756;9508.857367139499;9598.040195980346;9627.085426884434;9649.662261820802;9660.32377733552;7203.171635261907;7350.448716346295;7361.411087113018;7365.226651201654;7420.849768285924;6996.965015174892;7049.2950704931145;7060.576365418091;7062.611556364243;7074.50478466523;8182.7954301142945;8401.15988401155;8532.146785321667;8678.956605216934;8694.04365519805;8648.870266945874;8681.348898832739;8701.608427620899;8797;8827.602757875782;5570.19232211319;5741.483266506035;5742.224799652161;6249.218847644044;6433.388828061326;6501.674916254074;7105.28947105306;7258;7298.379637730853;7307.963460182665;6591.538592298493;6816.522843401112;6840.692168852314;6886.035954966409;6902.309769023058;6746.561473504206;6773.491988100814;6801.5238933274195;6835.487338449736;6897.068895699217;6968.442524597918;6968.930310696828;7030.261822508563;7043.154821421463;7043.225245222919;6474.838129046623;6475.546711730133;6542.378474044958;6542.967285163544;6547.1161393211305;6577.736890524326;6618.437432818265;6628.403443690091;6646.102776125162;6648.268690443951 17:03:29 INFO - PROCESS | 18460 | |4;prototype.html;314.3602768366374;315.5314358178105;322.5629272335985;323.6116660007991;325.34118410219287;5226.216067589863;5404.405515393309;5417.2686687297255;5430.5384042356345;5493.148561972891;5163.870903227412;5260.605454590902;5263.473652634734;5264.184051472019;5312.681239125655;3991.0621004064024;4055.837766489337;4086.346184610463;4167.229062623424;4175.893388252108;4141.565135660758;4154.501459824825;4159.292920203573;4163.542010378871;4169.332906734923;4128.979355103235;4131.834726610932;4132.710710250284;4142.834286628531;4151.83392664293;3981.840726370942;4008.6793056555553;4100.220958017967;4111.814968326403;4113.136241389282;3621.800800955946;3622.9637703623152;3632.527771389729;3638.909027274313;3641.435577485494;5013.548780609763;5023.372078490189;5024.045431368065;5025.1708468102715;5029.245613158019;4739.73931433771;4746.5490778376;4747.715137091751;4747.715137091785;4761.523847615245;5534.142207957773;5540.529055030287;5540.722963851791;5540.944590554123;5543.417941116206;3992.40113982902;4006.399040144002;4009.0578714002186;4015.7188996770237;4016.3975403689387;5634.605577609569;5861.824145275691;5863;5865.648061116347;5888.263967004124;3911.2959667260166;3969.027588240842;3976.0656245782798;3976.304146774303;3979.224051309967;4034.9798251009142;4034.9798251009142;4041.2523683118716;4042.777647229431;4048.797560122041;4649.790759415834;4649.86050418488;4659.277811939087;4668.996165824364;4669.836555720533;5609.074502707008;5610.97194514033;5613.158026296088;5613.607047506635;5614.719264036782;1463.2025546077414;1485.1608841004797;1486.7844162596364;1488.3525666335179;1495.3719437836135;948.6584829461389;973.9902600974041;980.8921018687938;1001.3641337750581;1002.4436437776958;4763.4522029967;4781.42622885256;4794.352762377104;4814.037192561502;4818.831340903052;5652.152177173457;5659.518940890071;5685.260916080966;5745.798897038583;5746.482816546531;4844.539768721966;4859.611231101503;4869.586085182799;4871.074495845849;4874.683145595596;3054.40439114375;3089.7991630543943;3093.582366380555;3094.1955091676327;3094.8143111412937;5409.729513524387;5434.538064264502;5439.156930675752;5441.809536666197;5444.700541470257;5710.65736055838;5838.182654428383;5839.299284085937;5850.0932355484965;5879.147523609053;5407.459254074561;5415.404305526389;5428.0500912340185;5433.076377015996;5436.347638283511;5712.485876271156;5713.05734553794;5723.7424315905055;5775.075987842093;5785.103308987113;5600.299962504687;5610.5231055360755;5612.803551875828;5613.831585052455;5615.522680572197;5414.566834653139;5420.4037555868035;5424.810131645373;5435.130379139318;5436.401995780382;3864.516935383077;3989.9800500997308;3999.9400008999305;4006.419069234886;4141.544430112625;5712.6860822012;5735.139729040678;5736.483716465538;5741.25363702716;5742.138679197987;5483.616146869681;5550.500454959073;5559.11054231321;5563.221149039056;5564.360098588714;5538.363088244903;5539.833804985857;5539.9169012464035;5548.69482178484;5549.417311182429;5453.618246722692;5457.590680698884;5464.235007099089;5466.3986961435;5478.397376288525;5431.945680543144;5541.667499950016;5572.052751032254;5587.804426845041;5600.551955843604;5405.702686352289;5447.591430642638;5452.182172674131;5452.454754524516;5456.42707515721 17:03:29 INFO - PROCESS | 18460 | |5;yui.html;663.3764261594101;753.3634079203072;767.8502691975067;783.1541934710509;790.7627711686492;12165.635030949075;12315.69210769729;12318.753624927496;12374.381280935952;12380.133390662657;11824.881751182485;12638.241705497654;12781.808272875915;12798.296093714842;12798.616041518746;653.6045692356128;790.3795520516396;800.3397197312212;801.683335082642;806.0609390060602;825.9421840471169;826.6486743134174;829.5188790501525;830.0744669693279;830.3855147191065;851.1573542193215;856.7344123321759;856.9571521423935;857.0957639690124;857.3741168946673;676.090658064902;835.9164083591592;844.6114787197896;852.552409984763;852.6504133305347;621.0776996160743;623.6133597169738;624.7126321891935;625.2091104752492;625.3184029407922;11981.580644677395;12018.098642601839;12044.578439754567;12047.337396443192;12053.819192712117;12012.459439325165;12371.195872268274;12510.249385036836;12690.555830545978;12705.491780328775;10034.347767395097;10129.189664826796;10195.337303075275;10281.126104281146;10340.689779306633;3413.6927676509235;3417.3677869594203;3436;3542.220711443478;3546.3261980223674;44107.55892441067;44176.77911610421;44315.55684443146;44544;44569.77715111436;9547.2839537035;9898;9899.257555683353;9940.10539051489;10235.59057637701;16908.830911690973;16931.153442327835;16978.066206358522;16982.32070717182;17011.574710632085;6972.198197207386;7102;7153.141623005168;7208.387287080657;7230.168530618941;3866.149447121629;3901.356276214393;3918.392649139388;3937.448757173998;4006.338954072604;2802.047303916678;2851.600775891377;2852.814567053135;2859.1565488181036;2863.599096126544;514.4161376837317;538.7877276128711;539.7247403824;544.6269305525727;557.6988426249861;556.4126810331989;573.6576411197817;609.6068036116679;631.9652419116901;666.5733930284622;7937.126916039231;8164.591770411455;8189.8771518427275;8194.426390152632;8370.53962032094;536.9785208591691;579.6724850459477;595.8808238352347;614.7387360371824;620.345535460094;3760.981195094007;3860.1700634363747;3924.3917192835156;3924.5879182685976;3957.2679054375035;47255.29117063178;47775.28337074877;48069;48156.759216204395;48293.517064829604;43145.35281970773;43443.01216080447;43803;44833.55166448359;44836.551634483236;39344;39463.80268098641;39772;40776.184476310904;40810.79594602008;7962.203779621991;8180.100188979089;8244.381671374551;8313.6674533018;8399.580020999048;31682.841585792845;31789;32073;32308.192295191868;32534.83732581322;37499.06252343713;37559.43660845144;38430.80784596059;39090;39578.60421395864;9907.405555666683;9964.551595178089;10001.14990225839;10002.149817265614;10359.135355636057;10388.480575971322;10680.57277708914;11890.227135236182;12151.574694885636;12396.31820249895;10985.945070274598;11205.71985700364;11579.421028948687;11882.821757673815;12133.453994570442;11288.774224515628;11338.773224535298;11620.360880151673;11790.764184716087;11998.940005300266;10534.736631584272;10677.526401158675;10880.67357979262;10940.070094041777;11283.379414131974;9479.241660667269;9715.27135464857;9792.216622670026;10008.84986725185;10052.849207262043;9798.461084640128;9955.452450115314;9988.300818942604;10012.64955726546;10052 17:03:29 INFO - PROCESS | 18460 | __end_tp_report 17:03:29 INFO - PROCESS | 18460 | __start_cc_report 17:03:29 INFO - PROCESS | 18460 | _x_x_mozilla_cycle_collect,1081 17:03:29 INFO - PROCESS | 18460 | __end_cc_report 17:03:29 INFO - PROCESS | 18460 | __startTimestamp1458950609633__endTimestamp 17:03:29 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | ------- Summary: start ------- 17:03:29 INFO - PROCESS | 18460 | Number of tests: 6 17:03:29 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | [#0] dojo.html Cycles:165 Average:4583.63 Median:4690.41 stddev:464.22 (9.9%) stddev-sans-first:438.96 17:03:29 INFO - PROCESS | 18460 | Values: 2605.9 2666.2 2670.6 2683.7 2706.0 4572.6 4575.1 4586.7 4589.3 4685.1 4612.7 4620.9 4648.4 4682.3 4685.3 4208.0 4229.6 4261.7 4293.0 4391.8 4319.2 4350.3 4355.4 4397.2 4402.6 4180.5 4220.8 4260.3 4291.6 4294.7 4255.8 4266.2 4300.2 4308.3 4315.2 4232.0 4242.2 4252.6 4265.4 4280.9 4473.9 4538.1 4540.6 4569.6 4623.4 4938.8 4944.3 4946.3 4947.7 4965.3 4951.2 4953.7 4960.7 4964.0 5009.7 4558.1 4624.0 4635.6 4709.5 4710.7 5036.6 5058.3 5059.3 5059.7 5095.5 4866.5 4868.4 4868.5 4912.2 4912.9 4790.0 4900.5 4934.1 4974.0 4980.5 4914.5 4926.3 4936.9 4938.0 4990.4 4933.5 4937.9 4939.7 4945.1 4987.5 4132.5 4161.4 4179.0 4192.3 4218.9 3679.7 3697.3 3703.8 3709.3 3726.0 4262.7 4263.1 4265.3 4296.0 4309.4 4903.0 4938.9 4964.4 5064.9 5065.5 4277.6 4282.6 4285.1 4285.3 4329.8 4447.4 4477.4 4479.9 4520.7 4525.7 4555.6 4635.0 4685.5 4713.7 4734.9 4923.3 4930.7 4940.4 4950.3 4975.6 4615.0 4666.3 4674.0 4675.0 4717.7 4870.8 4886.0 4889.3 4935.1 4941.1 4931.5 4961.9 4963.6 4970.1 5011.1 4690.4 4816.4 4826.1 4835.6 4867.7 4810.6 4833.3 4844.5 4845.0 4887.4 4756.1 4756.7 4760.6 4764.1 4800.7 4726.7 4793.9 4843.3 4893.8 4902.9 4653.1 4689.4 4725.6 4733.1 4744.1 17:03:29 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | [#1] ext.html Cycles:180 Average:38969.37 Median:18426.35 stddev:60747.67 (329.7%) stddev-sans-first:60849.51 17:03:29 INFO - PROCESS | 18460 | Values: 526.9 531.6 542.6 552.5 558.4 27002.9 34533.8 35075.5 35140.0 35201.0 36946.0 37554.0 37573.1 37601.2 37609.2 7609.1 7776.2 7783.5 7784.4 7790.5 7652.7 7675.3 7721.4 7745.5 7775.9 7726.2 7980.1 7992.8 7997.7 8001.5 7875.6 7919.1 7942.8 7948.7 7954.5 7750.7 7860.6 7874.6 7878.5 7878.6 38044.0 38249.4 38387.8 38403.2 38428.2 3109.2 3194.4 3217.3 3228.8 3604.5 28366.6 28477.9 29068.6 29185.3 29237.1 3355.7 3379.3 3383.3 3421.5 3437.1 231517.0 234488.0 234614.0 234842.0 235451.0 48926.0 53248.5 53730.7 54090.7 57274.4 51582.7 51889.2 51911.7 51931.2 52024.0 13689.7 13822.3 13884.7 13911.3 13925.7 9342.9 10448.6 10487.0 10632.7 10904.0 18369.9 18606.9 18673.0 18696.6 18726.2 6906.2 7234.5 7251.9 7307.2 7367.5 925.9 945.0 956.1 960.8 1036.8 26354.2 27150.5 27847.7 27858.4 27883.6 961.9 995.7 1023.4 1025.4 1058.0 14030.9 14357.8 14542.5 14567.3 14712.3 274736.0 278213.0 278382.0 278572.0 278606.0 45865.8 46825.0 46838.0 46941.5 47040.8 1067.6 1172.7 1184.3 1224.4 1252.5 24221.6 26055.2 26878.3 27069.3 27316.2 35407.0 35700.6 36117.3 36970.8 37011.3 167512.0 177402.0 179093.1 179212.0 179511.0 26609.5 30405.7 30675.3 30714.7 30729.2 34985.3 38270.8 38329.8 39044.4 39108.4 32992.7 33128.5 33308.5 33955.8 34066.0 32618.0 32828.2 33088.0 33292.8 33497.0 32772.5 32793.7 32880.7 33076.3 33259.7 28259.9 29535.0 29694.4 29802.9 29865.2 23292.9 23447.5 23761.0 23963.6 24104.9 17:03:29 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | [#2] jquery.html Cycles:180 Average:22651.26 Median:4724.39 stddev:60855.85 (1288.1%) stddev-sans-first:61003.51 17:03:29 INFO - PROCESS | 18460 | Values: 340.1 349.4 357.0 359.0 362.3 15398.8 15853.0 15902.8 16607.6 16610.8 10269.2 10485.5 10715.7 10880.5 10889.8 4579.0 4699.2 4705.4 4721.1 4727.7 3442.5 5113.7 5329.9 5377.3 5381.9 5406.1 5410.2 5420.2 5420.4 5446.9 5219.7 5361.9 5373.1 5413.1 5413.8 5108.1 5133.1 5151.1 5172.0 5176.2 12107.7 19134.0 19300.6 19663.2 19677.4 1923.9 2246.8 2422.9 2458.7 2459.0 9032.5 9080.3 9320.6 9451.5 9536.0 1768.4 1773.5 1773.5 1788.4 1811.8 60491.7 62993.7 63275.7 63613.4 63698.7 9472.0 9587.3 9595.7 9625.4 9665.2 13151.7 13250.0 13253.4 13260.9 13293.6 7008.4 7065.3 7081.4 7139.4 7164.7 6641.5 6777.3 6816.9 6841.3 6885.9 4121.5 4231.9 4261.6 4292.1 4310.8 1607.7 1681.4 1752.3 1762.3 1766.4 832.8 869.8 872.1 893.7 898.9 14868.2 15827.8 16073.5 16388.7 16536.4 868.3 871.5 891.5 955.7 979.1 9011.5 9329.2 9458.7 9463.7 9518.8 351662.0 353765.0 373870.0 380799.0 386654.0 67317.7 67544.7 68945.3 71511.0 72557.9 911.1 929.0 934.3 934.6 936.1 14494.6 14547.9 14601.6 14746.7 15044.2 32397.7 32533.3 32595.3 32698.2 33294.5 42356.8 45606.1 45907.0 46096.1 46506.5 7551.7 7576.1 7680.2 7715.3 7829.3 8600.8 10338.7 11222.9 11483.7 11864.0 9853.8 9900.2 9939.9 9973.5 10144.7 10034.7 10391.3 10506.6 10615.6 10686.8 10530.3 10592.7 10682.9 10693.0 10776.6 7432.6 7599.5 7648.6 7677.7 7723.4 7734.0 9480.1 9540.7 9716.4 10126.7 17:03:29 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | [#3] mootools.html Cycles:180 Average:5368.16 Median:5710.54 stddev:2788.24 (48.8%) stddev-sans-first:2779.36 17:03:29 INFO - PROCESS | 18460 | Values: 1308.6 1445.3 1482.0 1643.0 1794.7 7281.2 7485.6 7503.5 7512.2 7526.6 7308.1 7490.7 7506.1 7509.2 7509.4 1923.1 1968.0 1970.7 2266.9 2289.4 2249.8 2313.5 2316.1 2319.3 2319.4 2227.7 2260.4 2271.7 2272.9 2274.2 2254.4 2270.5 2271.5 2279.9 2282.0 2267.6 2270.8 2272.4 2288.5 2297.4 7535.3 7564.8 7572.6 7577.7 7600.4 4731.4 4845.6 4870.5 4878.1 4896.6 3029.1 3054.5 3209.6 3248.5 3263.6 1055.6 1067.6 1741.9 1751.7 1789.6 10217.6 10294.4 10366.8 10374.7 10385.0 4069.5 4179.9 4213.6 4260.1 4263.9 8344.1 8367.4 8376.7 8399.8 8402.2 4749.6 4774.4 4780.2 4795.9 4801.4 3782.4 4195.7 4341.6 4433.9 4446.2 3394.3 3404.6 3457.9 3480.6 3481.8 1032.8 1061.5 1063.9 1072.3 1074.3 1169.9 1181.8 1203.5 1209.0 1217.7 7104.5 7250.7 7273.4 7274.5 7328.6 446.4 453.3 457.9 458.6 459.9 5589.4 5652.1 5652.5 5654.2 5679.6 9263.0 9393.5 9603.3 9615.6 9756.0 9508.9 9598.0 9627.1 9649.7 9660.3 7203.2 7350.4 7361.4 7365.2 7420.8 6997.0 7049.3 7060.6 7062.6 7074.5 8182.8 8401.2 8532.1 8679.0 8694.0 8648.9 8681.3 8701.6 8797.0 8827.6 5570.2 5741.5 5742.2 6249.2 6433.4 6501.7 7105.3 7258.0 7298.4 7308.0 6591.5 6816.5 6840.7 6886.0 6902.3 6746.6 6773.5 6801.5 6835.5 6897.1 6968.4 6968.9 7030.3 7043.2 7043.2 6474.8 6475.5 6542.4 6543.0 6547.1 6577.7 6618.4 6628.4 6646.1 6648.3 17:03:29 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | [#4] prototype.html Cycles:180 Average:4614.23 Median:5263.83 stddev:1337.61 (25.4%) stddev-sans-first:1301.84 17:03:29 INFO - PROCESS | 18460 | Values: 314.4 315.5 322.6 323.6 325.3 5226.2 5404.4 5417.3 5430.5 5493.1 5163.9 5260.6 5263.5 5264.2 5312.7 3991.1 4055.8 4086.3 4167.2 4175.9 4141.6 4154.5 4159.3 4163.5 4169.3 4129.0 4131.8 4132.7 4142.8 4151.8 3981.8 4008.7 4100.2 4111.8 4113.1 3621.8 3623.0 3632.5 3638.9 3641.4 5013.5 5023.4 5024.0 5025.2 5029.2 4739.7 4746.5 4747.7 4747.7 4761.5 5534.1 5540.5 5540.7 5540.9 5543.4 3992.4 4006.4 4009.1 4015.7 4016.4 5634.6 5861.8 5863.0 5865.6 5888.3 3911.3 3969.0 3976.1 3976.3 3979.2 4035.0 4035.0 4041.3 4042.8 4048.8 4649.8 4649.9 4659.3 4669.0 4669.8 5609.1 5611.0 5613.2 5613.6 5614.7 1463.2 1485.2 1486.8 1488.4 1495.4 948.7 974.0 980.9 1001.4 1002.4 4763.5 4781.4 4794.4 4814.0 4818.8 5652.2 5659.5 5685.3 5745.8 5746.5 4844.5 4859.6 4869.6 4871.1 4874.7 3054.4 3089.8 3093.6 3094.2 3094.8 5409.7 5434.5 5439.2 5441.8 5444.7 5710.7 5838.2 5839.3 5850.1 5879.1 5407.5 5415.4 5428.1 5433.1 5436.3 5712.5 5713.1 5723.7 5775.1 5785.1 5600.3 5610.5 5612.8 5613.8 5615.5 5414.6 5420.4 5424.8 5435.1 5436.4 3864.5 3990.0 3999.9 4006.4 4141.5 5712.7 5735.1 5736.5 5741.3 5742.1 5483.6 5550.5 5559.1 5563.2 5564.4 5538.4 5539.8 5539.9 5548.7 5549.4 5453.6 5457.6 5464.2 5466.4 5478.4 5431.9 5541.7 5572.1 5587.8 5600.6 5405.7 5447.6 5452.2 5452.5 5456.4 17:03:29 INFO - PROCESS | 18460 | 17:03:29 INFO - PROCESS | 18460 | [#5] yui.html Cycles:180 Average:12572.67 Median:22391.26 stddev:13756.38 (61.4%) stddev-sans-first:13765.89 17:03:29 INFO - PROCESS | 18460 | Values: 663.4 753.4 767.9 783.2 790.8 12165.6 12315.7 12318.8 12374.4 12380.1 11824.9 12638.2 12781.8 12798.3 12798.6 653.6 790.4 800.3 801.7 806.1 825.9 826.6 829.5 830.1 830.4 851.2 856.7 857.0 857.1 857.4 676.1 835.9 844.6 852.6 852.7 621.1 623.6 624.7 625.2 625.3 11981.6 12018.1 12044.6 12047.3 12053.8 12012.5 12371.2 12510.2 12690.6 12705.5 10034.3 10129.2 10195.3 10281.1 10340.7 3413.7 3417.4 3436.0 3542.2 3546.3 44107.6 44176.8 44315.6 44544.0 44569.8 9547.3 9898.0 9899.3 9940.1 10235.6 16908.8 16931.2 16978.1 16982.3 17011.6 6972.2 7102.0 7153.1 7208.4 7230.2 3866.1 3901.4 3918.4 3937.4 4006.3 2802.0 2851.6 2852.8 2859.2 2863.6 514.4 538.8 539.7 544.6 557.7 556.4 573.7 609.6 632.0 666.6 7937.1 8164.6 8189.9 8194.4 8370.5 537.0 579.7 595.9 614.7 620.3 3761.0 3860.2 3924.4 3924.6 3957.3 47255.3 47775.3 48069.0 48156.8 48293.5 43145.4 43443.0 43803.0 44833.6 44836.6 39344.0 39463.8 39772.0 40776.2 40810.8 7962.2 8180.1 8244.4 8313.7 8399.6 31682.8 31789.0 32073.0 32308.2 32534.8 37499.1 37559.4 38430.8 39090.0 39578.6 9907.4 9964.6 10001.1 10002.1 10359.1 10388.5 10680.6 11890.2 12151.6 12396.3 10985.9 11205.7 11579.4 11882.8 12133.5 11288.8 11338.8 11620.4 11790.8 11998.9 10534.7 10677.5 10880.7 10940.1 11283.4 9479.2 9715.3 9792.2 10008.8 10052.8 9798.5 9955.5 9988.3 10012.6 10052.0 17:03:29 INFO - PROCESS | 18460 | -------- Summary: end -------- 17:03:29 INFO - PROCESS | 18460 | 17:03:30 INFO - TEST-INFO | 18460: exit 0 17:03:30 INFO - TEST-OK | dromaeo_css | took 1117237ms 17:03:30 INFO - TEST-START | kraken 17:03:30 INFO - operating with platform_type : linux_ 17:03:30 INFO - Initialising browser for kraken test... 17:03:30 INFO - TEST-INFO | started process 18638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpehUwoj/profile http://localhost:54025/getInfo.html) 17:03:34 INFO - PROCESS | 18638 | __metrics Screen width/height:1600/1200 17:03:34 INFO - PROCESS | 18638 | colorDepth:24 17:03:34 INFO - PROCESS | 18638 | Browser inner width/height: 1024/697 17:03:34 INFO - PROCESS | 18638 | __metrics 17:03:35 ERROR - PROCESS | 18638 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:03:36 INFO - TEST-INFO | 18638: exit 0 17:03:36 INFO - Browser initialized. 17:03:36 INFO - Running cycle 1/1 for kraken test... 17:03:36 INFO - TEST-INFO | started process 18722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpehUwoj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:48 INFO - PROCESS | 18722 | RSS: Main: 155406336 17:03:48 INFO - PROCESS | 18722 | 17:03:51 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54025/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:51 INFO - PROCESS | 18722 | RSS: Main: 195768320 17:03:51 INFO - PROCESS | 18722 | 17:03:54 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54025/tests/kraken/driver.html?testName=audio-dft) 17:03:55 INFO - PROCESS | 18722 | RSS: Main: 185749504 17:03:55 INFO - PROCESS | 18722 | 17:03:58 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54025/tests/kraken/driver.html?testName=audio-fft) 17:03:58 INFO - PROCESS | 18722 | RSS: Main: 172040192 17:03:58 INFO - PROCESS | 18722 | 17:04:00 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54025/tests/kraken/driver.html?testName=audio-oscillator) 17:04:01 INFO - PROCESS | 18722 | RSS: Main: 172253184 17:04:01 INFO - PROCESS | 18722 | 17:04:03 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54025/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:04 INFO - PROCESS | 18722 | RSS: Main: 174137344 17:04:04 INFO - PROCESS | 18722 | 17:04:07 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54025/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:07 INFO - PROCESS | 18722 | RSS: Main: 174243840 17:04:07 INFO - PROCESS | 18722 | 17:04:11 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54025/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:12 INFO - PROCESS | 18722 | RSS: Main: 172580864 17:04:12 INFO - PROCESS | 18722 | 17:04:14 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54025/tests/kraken/driver.html?testName=json-parse-financial) 17:04:15 INFO - PROCESS | 18722 | RSS: Main: 172949504 17:04:15 INFO - PROCESS | 18722 | 17:04:17 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54025/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:04:17 INFO - PROCESS | 18722 | RSS: Main: 189128704 17:04:17 INFO - PROCESS | 18722 | 17:04:19 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54025/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:04:20 INFO - PROCESS | 18722 | RSS: Main: 187715584 17:04:20 INFO - PROCESS | 18722 | 17:04:22 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54025/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:04:22 INFO - PROCESS | 18722 | RSS: Main: 200962048 17:04:22 INFO - PROCESS | 18722 | 17:04:25 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54025/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:26 INFO - PROCESS | 18722 | RSS: Main: 204341248 17:04:26 INFO - PROCESS | 18722 | 17:04:28 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54025/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:29 INFO - PROCESS | 18722 | RSS: Main: 202280960 17:04:29 INFO - PROCESS | 18722 | 17:04:30 INFO - PROCESS | 18722 | Cycle 1(1): loaded http://localhost:54025/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54025/tests/kraken/driver.html?testName=ai-astar) 17:04:31 INFO - PROCESS | 18722 | RSS: Main: 263487488 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | __start_tp_report 17:04:31 INFO - PROCESS | 18722 | _x_x_mozilla_page_load 17:04:31 INFO - PROCESS | 18722 | _x_x_mozilla_page_load_details 17:04:31 INFO - PROCESS | 18722 | |i|pagename|runs| 17:04:31 INFO - PROCESS | 18722 | |0;ai-astar;111;113;107;113;114;113;101;112;112;112 17:04:31 INFO - PROCESS | 18722 | |1;audio-beat-detection;161;135;153;184;134;155;160;133;177;134 17:04:31 INFO - PROCESS | 18722 | |2;audio-dft;163;161;161;160;161;162;162;160;161;163 17:04:31 INFO - PROCESS | 18722 | |3;audio-fft;74;74;106;103;74;76;73;107;96;74 17:04:31 INFO - PROCESS | 18722 | |4;audio-oscillator;94;94;141;94;94;96;150;93;93;137 17:04:31 INFO - PROCESS | 18722 | |5;imaging-gaussian-blur;117;118;118;119;117;117;117;117;117;117 17:04:31 INFO - PROCESS | 18722 | |6;imaging-darkroom;146;145;147;146;146;147;146;146;146;146 17:04:31 INFO - PROCESS | 18722 | |7;imaging-desaturate;96;96;95;95;95;96;96;95;96;96 17:04:31 INFO - PROCESS | 18722 | |8;json-parse-financial;63;66;64;64;64;65;63;73;62;61 17:04:31 INFO - PROCESS | 18722 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;64;64;64 17:04:31 INFO - PROCESS | 18722 | |10;stanford-crypto-aes;83;83;83;82;84;82;82;82;82;83 17:04:31 INFO - PROCESS | 18722 | |11;stanford-crypto-ccm;125;119;120;123;116;122;115;125;117;132 17:04:31 INFO - PROCESS | 18722 | |12;stanford-crypto-pbkdf2;145;131;141;142;147;135;144;142;143;147 17:04:31 INFO - PROCESS | 18722 | |13;stanford-crypto-sha256-iterative;70;69;68;67;70;66;67;68;66;68 17:04:31 INFO - PROCESS | 18722 | __end_tp_report 17:04:31 INFO - PROCESS | 18722 | __start_cc_report 17:04:31 INFO - PROCESS | 18722 | _x_x_mozilla_cycle_collect,1147 17:04:31 INFO - PROCESS | 18722 | __end_cc_report 17:04:31 INFO - PROCESS | 18722 | __startTimestamp1458950671231__endTimestamp 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | ------- Summary: start ------- 17:04:31 INFO - PROCESS | 18722 | Number of tests: 14 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:3.94 (3.5%) stddev-sans-first:4.18 17:04:31 INFO - PROCESS | 18722 | Values: 111.0 113.0 107.0 113.0 114.0 113.0 101.0 112.0 112.0 112.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:157.50 stddev:18.55 (11.8%) stddev-sans-first:19.43 17:04:31 INFO - PROCESS | 18722 | Values: 161.0 135.0 153.0 184.0 134.0 155.0 160.0 133.0 177.0 134.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:0.97 17:04:31 INFO - PROCESS | 18722 | Values: 163.0 161.0 161.0 160.0 161.0 162.0 162.0 160.0 161.0 163.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#3] audio-fft Cycles:10 Average:85.70 Median:74.00 stddev:15.18 (20.5%) stddev-sans-first:15.50 17:04:31 INFO - PROCESS | 18722 | Values: 74.0 74.0 106.0 103.0 74.0 76.0 73.0 107.0 96.0 74.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:94.00 stddev:23.73 (25.2%) stddev-sans-first:24.58 17:04:31 INFO - PROCESS | 18722 | Values: 94.0 94.0 141.0 94.0 94.0 96.0 150.0 93.0 93.0 137.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:04:31 INFO - PROCESS | 18722 | Values: 117.0 118.0 118.0 119.0 117.0 117.0 117.0 117.0 117.0 117.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:04:31 INFO - PROCESS | 18722 | Values: 146.0 145.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:04:31 INFO - PROCESS | 18722 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:3.31 (5.2%) stddev-sans-first:3.46 17:04:31 INFO - PROCESS | 18722 | Values: 63.0 66.0 64.0 64.0 64.0 65.0 63.0 73.0 62.0 61.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 17:04:31 INFO - PROCESS | 18722 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 17:04:31 INFO - PROCESS | 18722 | Values: 83.0 83.0 83.0 82.0 84.0 82.0 82.0 82.0 82.0 83.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.50 stddev:5.15 (4.2%) stddev-sans-first:5.29 17:04:31 INFO - PROCESS | 18722 | Values: 125.0 119.0 120.0 123.0 116.0 122.0 115.0 125.0 117.0 132.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:143.50 stddev:5.10 (3.6%) stddev-sans-first:5.27 17:04:31 INFO - PROCESS | 18722 | Values: 145.0 131.0 141.0 142.0 147.0 135.0 144.0 142.0 143.0 147.0 17:04:31 INFO - PROCESS | 18722 | 17:04:31 INFO - PROCESS | 18722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.32 17:04:31 INFO - PROCESS | 18722 | Values: 70.0 69.0 68.0 67.0 70.0 66.0 67.0 68.0 66.0 68.0 17:04:31 INFO - PROCESS | 18722 | -------- Summary: end -------- 17:04:31 INFO - PROCESS | 18722 | 17:04:32 INFO - TEST-INFO | 18722: exit 0 17:04:32 INFO - TEST-OK | kraken | took 61834ms 17:04:32 INFO - SUITE-END | took 1179s 17:04:32 INFO - Completed test suite (00:19:39) 17:04:32 INFO - javascript benchmark 17:04:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2605.8697065146744, 2666.1601595497405, 2670.550863256064, 2683.6511253537024, 2705.9729402705975, 4572.634189264859, 4575.130725162217, 4586.678932474724, 4589.311603259504, 4685.109829132462, 4612.723236605806, 4620.907581848361, 4648.442186937572, 4682.274247491636, 4685.3206285088645, 4207.9789601052025, 4229.577042295761, 4261.744295342274, 4293.0, 4391.802368893392, 4319.157764235975, 4350.347447882811, 4355.368471571636, 4397.230484665187, 4402.625776808975, 4180.519240287345, 4220.78896055199, 4260.297050986584, 4291.57084291573, 4294.720843145185, 4255.8084886180195, 4266.189424009459, 4300.182965236595, 4308.267594508941, 4315.201687687788, 4231.957680423187, 4242.215190189794, 4252.596003379674, 4265.402843601898, 4280.892977675552, 4473.888152796206, 4538.137753826795, 4540.568645978627, 4569.588737013684, 4623.42207224097, 4938.827141050046, 4944.258361245842, 4946.307516947594, 4947.727874966876, 4965.329680493123, 4951.232558953368, 4953.702777833341, 4960.677555958887, 4963.950360496385, 5009.699418034893, 4558.133954548625, 4624.028953919647, 4635.605973492257, 4709.458412282632, 4710.717356958594, 5036.647434679538, 5058.291839142523, 5059.342285502935, 5059.747012649353, 5095.490450954875, 4866.513348665105, 4868.391451068616, 4868.537488938545, 4912.214045752662, 4912.901741965141, 4790.041991601694, 4900.509949005071, 4934.1118598651865, 4974.030064137531, 4980.526849949249, 4914.533119353727, 4926.285688575136, 4936.901261974812, 4937.950620493749, 4990.426100998359, 4933.45731969483, 4937.925931111036, 4939.654224204343, 4945.109880221523, 4987.451380348159, 4132.5454200037975, 4161.417401563784, 4178.979105104455, 4192.266353388145, 4218.894527636834, 3679.6504332088407, 3697.315996540595, 3703.814809259526, 3709.2581483703366, 3726.0, 4262.744235345889, 4263.126059157865, 4265.317549192115, 4296.033392486728, 4309.418228539107, 4903.0, 4938.925916111261, 4964.354633897642, 5064.924026139611, 5065.544101030851, 4277.636400905958, 4282.614564689193, 4285.121550082225, 4285.335772955197, 4329.783510824446, 4447.421835161408, 4477.440319960005, 4479.932801007987, 4520.683552151384, 4525.728456292633, 4555.567221113989, 4634.9536504634525, 4685.461171965268, 4713.6936099153445, 4734.928976065293, 4923.261510773413, 4930.704157750546, 4940.431850337257, 4950.257461380822, 4975.577075948585, 4615.0, 4666.323383109362, 4673.953260467351, 4674.953250467452, 4717.716936983792, 4870.78081486341, 4886.047220792054, 4889.291052797395, 4935.136351138464, 4941.085899108676, 4931.50684931504, 4961.875953101201, 4963.627727920492, 4970.080535101018, 5011.072951503984, 4690.413698287714, 4816.446108697404, 4826.131296366547, 4835.637327200404, 4867.683600565952, 4810.5670489656095, 4833.347498087714, 4844.491328410466, 4845.0, 4887.36464259644, 4756.120117778222, 4756.6908150970075, 4760.595349395202, 4764.094821983812, 4800.73595952226, 4726.692764970266, 4793.9280910785665, 4843.2735089736825, 4893.828715994923, 4902.901941961212, 4653.139169253699, 4689.437267527918, 4725.5510726480925, 4733.053389322081, 4744.051189761993], "unit": "score", "name": "dojo.html", "value": 4555.2851454294205}, {"lowerIsBetter": false, "replicates": [526.8709166254266, 531.5853634165351, 542.5713686187912, 552.4999875113024, 558.3969313141806, 27002.864985675067, 34533.82733086337, 35075.473867892004, 35140.0, 35201.00791432731, 36946.0, 37554.0, 37573.11549498568, 37601.247975040555, 37609.24781504368, 7609.124950630693, 7776.222377762235, 7783.494072885244, 7784.377249820029, 7790.532568045907, 7652.693892244303, 7675.270849269338, 7721.420893432987, 7745.535267883917, 7775.883361749578, 7726.188750181234, 7980.082290536576, 7992.840143197132, 7997.680092796281, 8001.479903806234, 7875.606219689022, 7919.089304729972, 7942.801429964239, 7948.682052717884, 7954.522728636301, 7750.689972401097, 7860.646270917822, 7874.5668988205625, 7878.527288362717, 7878.645460954271, 38044.0, 38249.426258606145, 38387.8080609598, 38403.231935361415, 38428.23143537142, 3109.238236632017, 3194.37709646619, 3217.2921957169387, 3228.7739858209934, 3604.4953706481115, 28366.574501382496, 28477.85761071202, 29068.563971540232, 29185.270368240963, 29237.122886313446, 3355.697987181141, 3379.2734562069027, 3383.2725963917874, 3421.5209870618132, 3437.089171369589, 231517.0, 234488.0, 234614.0, 234842.0, 235451.0, 48926.0, 53248.46751532512, 53730.7313463438, 54090.72954635201, 57274.42725572691, 51582.74208628933, 51889.2216616751, 51911.74044129755, 51931.22103168455, 52024.0, 13689.726205475834, 13822.308884555732, 13884.652883677787, 13911.30443477822, 13925.651858703613, 9342.90657093434, 10448.634297799541, 10487.0, 10632.734181645521, 10904.0, 18369.908150459163, 18606.906965465358, 18673.0, 18696.626067478846, 18726.157322920502, 6906.240313565504, 7234.529755565872, 7251.92748072523, 7307.2327405621645, 7367.5211111277595, 925.9120383563551, 944.9558238146749, 956.0821611253275, 960.846264597661, 1036.79782442423, 26354.20937371882, 27150.45699086007, 27847.72152278492, 27858.442831143264, 27883.581746273823, 961.8893827209821, 995.7411073121041, 1023.4371095897227, 1025.395016939994, 1057.9947100264449, 14030.929845350707, 14357.78463323051, 14542.4910128145, 14567.271636418349, 14712.33794479251, 274736.0, 278213.0, 278382.0, 278572.0, 278606.0, 45865.770671146434, 46825.0, 46838.0, 46941.530584694396, 47040.76479617648, 1067.631667074858, 1172.6775136837268, 1184.283508477376, 1224.4489979509078, 1252.5490823303603, 24221.63667544953, 26055.218343449727, 26878.32804179911, 27069.323266918484, 27316.180514584594, 35407.0, 35700.64299356973, 36117.27765444624, 36970.8151459241, 37011.259774804894, 167512.0, 177402.0, 179093.1045344765, 179212.0, 179511.0, 26609.467810644066, 30405.695943040286, 30675.318961724737, 30714.692853071185, 30729.231769205053, 34985.30029399347, 38270.80864595659, 38329.80835095807, 39044.41433378445, 39108.41337379999, 32992.67007329896, 33128.52150524257, 33308.50037249492, 33955.83022084874, 34066.0, 32618.021459356256, 32828.17929551685, 33088.0, 33292.833535832164, 33497.0, 32772.50841237431, 32793.67206327906, 32880.67119328872, 33076.338473230884, 33259.667403326624, 28259.858700706365, 29535.0, 29694.406111877208, 29802.85098574493, 29865.200107600176, 23292.883535582212, 23447.51071974686, 23761.0, 23963.640545392183, 24104.87947560251], "unit": "score", "name": "ext.html", "value": 16626.560257446563}, {"lowerIsBetter": false, "replicates": [340.10382641739017, 349.3850822552307, 357.039563573986, 358.9784612923225, 362.26835725233394, 15398.846011539881, 15853.048817070983, 15902.76145857813, 16607.584810379747, 16610.83389166108, 10269.22980776441, 10485.475726213697, 10715.732106697316, 10880.455977201147, 10889.83665245022, 4578.999999999992, 4699.248120300753, 4705.435347758274, 4721.055788842228, 4727.716337019772, 3442.4664177052596, 5113.744312784364, 5329.920051199235, 5377.327834020747, 5381.919271210935, 5406.053940560406, 5410.161424979135, 5420.159875219328, 5420.403755586883, 5446.863828404302, 5219.686818790885, 5361.892762144755, 5373.113436283009, 5413.133898576229, 5413.783448662069, 5108.106081435734, 5133.050385678662, 5151.098557752378, 5172.017316709813, 5176.171812509981, 12107.697307567294, 19134.0, 19300.552458565522, 19663.213471461266, 19677.409677709693, 1923.9422817315503, 2246.7865552772623, 2422.880104235562, 2458.741832107639, 2458.987705061463, 9032.54837258141, 9080.318976076755, 9320.627174912996, 9451.480168590724, 9536.046395360478, 1768.3633891798943, 1773.485689150145, 1773.5211492896847, 1788.3740690758261, 1811.7644706188244, 60491.69754151201, 62993.685031575005, 63275.6836215816, 63613.36386636121, 63698.681506592635, 9471.952640236892, 9587.280953928483, 9595.664151754794, 9625.422474651543, 9665.178459830853, 13151.671208219872, 13250.0, 13253.403596838165, 13260.933695331461, 13293.601191964257, 7008.439324853999, 7065.258147894397, 7081.362677358959, 7139.357457828821, 7164.749233776793, 6641.501887358468, 6777.322267773282, 6816.931830681629, 6841.281665425158, 6885.931140688629, 4121.4848143982, 4231.894202644959, 4261.616454519108, 4292.077203401222, 4310.792977966112, 1607.6704275623704, 1681.3946979087518, 1752.281564558525, 1762.3038899634828, 1766.3994241957796, 832.8334333133398, 869.8347314010318, 872.1148034744739, 893.7497500699815, 898.8651702244715, 14868.182249976138, 15827.841721582638, 16073.517794466185, 16388.6722265554, 16536.421225257058, 868.3313848336871, 871.4988881393224, 891.4562117108559, 955.7306739088538, 979.0943377375899, 9011.459312441275, 9329.16037556623, 9458.716238512718, 9463.668771592962, 9518.825323723811, 351662.0, 353765.0, 373870.0, 380799.0, 386654.0, 67317.66341168263, 67544.66227668831, 68945.31054689489, 71511.0, 72557.91163132557, 911.1344222988188, 929.0477260807592, 934.289939645874, 934.6261495401893, 936.1340759797297, 14494.565163045125, 14547.910376609283, 14601.561953141423, 14746.705065898408, 15044.247787610357, 32397.67602324041, 32533.34933301368, 32595.348093037534, 32698.182545436553, 33294.5005824908, 42356.788216058725, 45606.08787824291, 45907.0, 46096.07807843891, 46506.53493465022, 7551.660175292015, 7576.1287451941525, 7680.155182929985, 7715.267049630276, 7829.256220659028, 8600.78498037554, 10338.741531461774, 11222.88777112251, 11483.712907177052, 11864.0, 9853.802923941337, 9900.158486528726, 9939.900600994186, 9973.45146016947, 10144.746381340525, 10034.749131271778, 10391.324563903323, 10506.579736810747, 10615.628453004108, 10686.839697404701, 10530.262881598215, 10592.682219533426, 10682.916831217837, 10693.0, 10776.622818201326, 7432.554046757212, 7599.544027358376, 7648.579328137006, 7677.731279405194, 7723.420743444151, 7733.994580704698, 9480.146786788946, 9540.713778586654, 9716.368436051634, 10126.746831329276], "unit": "score", "name": "jquery.html", "value": 7845.386240723676}, {"lowerIsBetter": false, "replicates": [1308.6139588821297, 1445.306252998561, 1481.95554133376, 1643.038822288961, 1794.6500432415676, 7281.199068102511, 7485.588292643909, 7503.512271702336, 7512.173660897311, 7526.586037767921, 7308.086489188851, 7490.737824176155, 7506.061742282215, 7509.173990861001, 7509.361704255145, 1923.1153669312134, 1968.0258272155231, 1970.7339509166222, 2266.9433264168447, 2289.416198869286, 2249.80876625487, 2313.53729254149, 2316.050419328076, 2319.2694301295123, 2319.4433335999324, 2227.732672079345, 2260.389694782408, 2271.681964524968, 2272.8522646028036, 2274.2267629006133, 2254.391314345134, 2270.5345404192103, 2271.522980174157, 2279.943001424969, 2281.9657705134437, 2267.6258417361114, 2270.8069814065825, 2272.4432514034165, 2288.473651060249, 2297.356740112771, 7535.321821036133, 7564.848703025964, 7572.583507907063, 7577.696892124309, 7600.391968642495, 4731.384919960383, 4845.563899249085, 4870.512948705136, 4878.121938051149, 4896.608271338285, 3029.091272618206, 3054.5112781955004, 3209.646938836726, 3248.4964830451318, 3263.5594194783876, 1055.625253035177, 1067.5889782433742, 1741.939032133882, 1751.6846967545837, 1789.5615574184408, 10217.642382516651, 10294.3823370598, 10366.792664146675, 10374.740631484274, 10385.0, 4069.4709687740406, 4179.916401672011, 4213.620774130343, 4260.084081922401, 4263.850765223202, 8344.08215096339, 8367.372447066495, 8376.706815261437, 8399.832003360021, 8402.243798058082, 4749.572538471485, 4774.379330686988, 4780.163471392562, 4795.880102997453, 4801.375821143229, 3782.3569993101237, 4195.727277726938, 4341.565843415697, 4433.933490997638, 4446.199684056901, 3394.253264281854, 3404.5914490261325, 3457.896263112111, 3480.63453337401, 3481.7910925344054, 1032.829583118792, 1061.5223149582564, 1063.9095676867553, 1072.2601405030505, 1074.2748644664975, 1169.8771628979005, 1181.8313394920417, 1203.5125774061519, 1209.0327737809716, 1217.738186289952, 7104.467164962649, 7250.709971601183, 7273.418126549864, 7274.454415918827, 7328.560286382834, 446.37730366139056, 453.31549360465937, 457.9015511665008, 458.550620392011, 459.91951408503377, 5589.357223919302, 5652.095664693629, 5652.519535839418, 5654.180143879114, 5679.602427830095, 9262.95368523153, 9393.5303234838, 9603.279754018477, 9615.615375385047, 9756.0, 9508.857367139499, 9598.040195980346, 9627.085426884434, 9649.662261820802, 9660.32377733552, 7203.171635261907, 7350.448716346295, 7361.411087113018, 7365.226651201654, 7420.849768285924, 6996.965015174892, 7049.2950704931145, 7060.576365418091, 7062.611556364243, 7074.50478466523, 8182.7954301142945, 8401.15988401155, 8532.146785321667, 8678.956605216934, 8694.04365519805, 8648.870266945874, 8681.348898832739, 8701.608427620899, 8797.0, 8827.602757875782, 5570.19232211319, 5741.483266506035, 5742.224799652161, 6249.218847644044, 6433.388828061326, 6501.674916254074, 7105.28947105306, 7258.0, 7298.379637730853, 7307.963460182665, 6591.538592298493, 6816.522843401112, 6840.692168852314, 6886.035954966409, 6902.309769023058, 6746.561473504206, 6773.491988100814, 6801.5238933274195, 6835.487338449736, 6897.068895699217, 6968.442524597918, 6968.930310696828, 7030.261822508563, 7043.154821421463, 7043.225245222919, 6474.838129046623, 6475.546711730133, 6542.378474044958, 6542.967285163544, 6547.1161393211305, 6577.736890524326, 6618.437432818265, 6628.403443690091, 6646.102776125162, 6648.268690443951], "unit": "score", "name": "mootools.html", "value": 4357.813695367467}, {"lowerIsBetter": false, "replicates": [314.3602768366374, 315.5314358178105, 322.5629272335985, 323.6116660007991, 325.34118410219287, 5226.216067589863, 5404.405515393309, 5417.2686687297255, 5430.5384042356345, 5493.148561972891, 5163.870903227412, 5260.605454590902, 5263.473652634734, 5264.184051472019, 5312.681239125655, 3991.0621004064024, 4055.837766489337, 4086.346184610463, 4167.229062623424, 4175.893388252108, 4141.565135660758, 4154.501459824825, 4159.292920203573, 4163.542010378871, 4169.332906734923, 4128.979355103235, 4131.834726610932, 4132.710710250284, 4142.834286628531, 4151.83392664293, 3981.840726370942, 4008.6793056555553, 4100.220958017967, 4111.814968326403, 4113.136241389282, 3621.800800955946, 3622.9637703623152, 3632.527771389729, 3638.909027274313, 3641.435577485494, 5013.548780609763, 5023.372078490189, 5024.045431368065, 5025.1708468102715, 5029.245613158019, 4739.73931433771, 4746.5490778376, 4747.715137091751, 4747.715137091785, 4761.523847615245, 5534.142207957773, 5540.529055030287, 5540.722963851791, 5540.944590554123, 5543.417941116206, 3992.40113982902, 4006.399040144002, 4009.0578714002186, 4015.7188996770237, 4016.3975403689387, 5634.605577609569, 5861.824145275691, 5863.0, 5865.648061116347, 5888.263967004124, 3911.2959667260166, 3969.027588240842, 3976.0656245782798, 3976.304146774303, 3979.224051309967, 4034.9798251009142, 4034.9798251009142, 4041.2523683118716, 4042.777647229431, 4048.797560122041, 4649.790759415834, 4649.86050418488, 4659.277811939087, 4668.996165824364, 4669.836555720533, 5609.074502707008, 5610.97194514033, 5613.158026296088, 5613.607047506635, 5614.719264036782, 1463.2025546077414, 1485.1608841004797, 1486.7844162596364, 1488.3525666335179, 1495.3719437836135, 948.6584829461389, 973.9902600974041, 980.8921018687938, 1001.3641337750581, 1002.4436437776958, 4763.4522029967, 4781.42622885256, 4794.352762377104, 4814.037192561502, 4818.831340903052, 5652.152177173457, 5659.518940890071, 5685.260916080966, 5745.798897038583, 5746.482816546531, 4844.539768721966, 4859.611231101503, 4869.586085182799, 4871.074495845849, 4874.683145595596, 3054.40439114375, 3089.7991630543943, 3093.582366380555, 3094.1955091676327, 3094.8143111412937, 5409.729513524387, 5434.538064264502, 5439.156930675752, 5441.809536666197, 5444.700541470257, 5710.65736055838, 5838.182654428383, 5839.299284085937, 5850.0932355484965, 5879.147523609053, 5407.459254074561, 5415.404305526389, 5428.0500912340185, 5433.076377015996, 5436.347638283511, 5712.485876271156, 5713.05734553794, 5723.7424315905055, 5775.075987842093, 5785.103308987113, 5600.299962504687, 5610.5231055360755, 5612.803551875828, 5613.831585052455, 5615.522680572197, 5414.566834653139, 5420.4037555868035, 5424.810131645373, 5435.130379139318, 5436.401995780382, 3864.516935383077, 3989.9800500997308, 3999.9400008999305, 4006.419069234886, 4141.544430112625, 5712.6860822012, 5735.139729040678, 5736.483716465538, 5741.25363702716, 5742.138679197987, 5483.616146869681, 5550.500454959073, 5559.11054231321, 5563.221149039056, 5564.360098588714, 5538.363088244903, 5539.833804985857, 5539.9169012464035, 5548.69482178484, 5549.417311182429, 5453.618246722692, 5457.590680698884, 5464.235007099089, 5466.3986961435, 5478.397376288525, 5431.945680543144, 5541.667499950016, 5572.052751032254, 5587.804426845041, 5600.551955843604, 5405.702686352289, 5447.591430642638, 5452.182172674131, 5452.454754524516, 5456.42707515721], "unit": "score", "name": "prototype.html", "value": 4191.610147712979}, {"lowerIsBetter": false, "replicates": [663.3764261594101, 753.3634079203072, 767.8502691975067, 783.1541934710509, 790.7627711686492, 12165.635030949075, 12315.69210769729, 12318.753624927496, 12374.381280935952, 12380.133390662657, 11824.881751182485, 12638.241705497654, 12781.808272875915, 12798.296093714842, 12798.616041518746, 653.6045692356128, 790.3795520516396, 800.3397197312212, 801.683335082642, 806.0609390060602, 825.9421840471169, 826.6486743134174, 829.5188790501525, 830.0744669693279, 830.3855147191065, 851.1573542193215, 856.7344123321759, 856.9571521423935, 857.0957639690124, 857.3741168946673, 676.090658064902, 835.9164083591592, 844.6114787197896, 852.552409984763, 852.6504133305347, 621.0776996160743, 623.6133597169738, 624.7126321891935, 625.2091104752492, 625.3184029407922, 11981.580644677395, 12018.098642601839, 12044.578439754567, 12047.337396443192, 12053.819192712117, 12012.459439325165, 12371.195872268274, 12510.249385036836, 12690.555830545978, 12705.491780328775, 10034.347767395097, 10129.189664826796, 10195.337303075275, 10281.126104281146, 10340.689779306633, 3413.6927676509235, 3417.3677869594203, 3436.0, 3542.220711443478, 3546.3261980223674, 44107.55892441067, 44176.77911610421, 44315.55684443146, 44544.0, 44569.77715111436, 9547.2839537035, 9898.0, 9899.257555683353, 9940.10539051489, 10235.59057637701, 16908.830911690973, 16931.153442327835, 16978.066206358522, 16982.32070717182, 17011.574710632085, 6972.198197207386, 7102.0, 7153.141623005168, 7208.387287080657, 7230.168530618941, 3866.149447121629, 3901.356276214393, 3918.392649139388, 3937.448757173998, 4006.338954072604, 2802.047303916678, 2851.600775891377, 2852.814567053135, 2859.1565488181036, 2863.599096126544, 514.4161376837317, 538.7877276128711, 539.7247403824, 544.6269305525727, 557.6988426249861, 556.4126810331989, 573.6576411197817, 609.6068036116679, 631.9652419116901, 666.5733930284622, 7937.126916039231, 8164.591770411455, 8189.8771518427275, 8194.426390152632, 8370.53962032094, 536.9785208591691, 579.6724850459477, 595.8808238352347, 614.7387360371824, 620.345535460094, 3760.981195094007, 3860.1700634363747, 3924.3917192835156, 3924.5879182685976, 3957.2679054375035, 47255.29117063178, 47775.28337074877, 48069.0, 48156.759216204395, 48293.517064829604, 43145.35281970773, 43443.01216080447, 43803.0, 44833.55166448359, 44836.551634483236, 39344.0, 39463.80268098641, 39772.0, 40776.184476310904, 40810.79594602008, 7962.203779621991, 8180.100188979089, 8244.381671374551, 8313.6674533018, 8399.580020999048, 31682.841585792845, 31789.0, 32073.0, 32308.192295191868, 32534.83732581322, 37499.06252343713, 37559.43660845144, 38430.80784596059, 39090.0, 39578.60421395864, 9907.405555666683, 9964.551595178089, 10001.14990225839, 10002.149817265614, 10359.135355636057, 10388.480575971322, 10680.57277708914, 11890.227135236182, 12151.574694885636, 12396.31820249895, 10985.945070274598, 11205.71985700364, 11579.421028948687, 11882.821757673815, 12133.453994570442, 11288.774224515628, 11338.773224535298, 11620.360880151673, 11790.764184716087, 11998.940005300266, 10534.736631584272, 10677.526401158675, 10880.67357979262, 10940.070094041777, 11283.379414131974, 9479.241660667269, 9715.27135464857, 9792.216622670026, 10008.84986725185, 10052.849207262043, 9798.461084640128, 9955.452450115314, 9988.300818942604, 10012.64955726546, 10052.0], "unit": "score", "name": "yui.html", "value": 5974.341585746533}], "name": "dromaeo_css", "value": 6338.486854357124}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 113.0, 114.0, 113.0, 101.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [161.0, 135.0, 153.0, 184.0, 134.0, 155.0, 160.0, 133.0, 177.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.6}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 160.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 106.0, 103.0, 74.0, 76.0, 73.0, 107.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 141.0, 94.0, 94.0, 96.0, 150.0, 93.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 64.0, 64.0, 64.0, 65.0, 63.0, 73.0, 62.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 64.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 82.0, 84.0, 82.0, 82.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [125.0, 119.0, 120.0, 123.0, 116.0, 122.0, 115.0, 125.0, 117.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [145.0, 131.0, 141.0, 142.0, 147.0, 135.0, 144.0, 142.0, 143.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 67.0, 70.0, 66.0, 67.0, 68.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1520.3999999999999}]} 17:04:32 INFO - Return code: 0 17:04:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:04:32 ERROR - # TBPL SUCCESS # 17:04:32 INFO - Running post-action listener: _resource_record_post_action 17:04:32 INFO - Running post-run listener: _resource_record_post_run 17:04:33 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 282132480; Read time: 0; Write time: 272136 17:04:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7000064; Read time: 0; Write time: 5276 17:04:33 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 274866176; Read time: 0; Write time: 266860 17:04:33 INFO - Running post-run listener: _upload_blobber_files 17:04:33 INFO - Blob upload gear active. 17:04:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:04:33 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 17:04:33 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'] 17:04:33 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 17:04:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:04:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:04:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:34 INFO - (blobuploader) - INFO - Done attempting. 17:04:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:04:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:04:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:35 INFO - (blobuploader) - INFO - Done attempting. 17:04:35 INFO - (blobuploader) - INFO - Iteration through files over. 17:04:35 INFO - Return code: 0 17:04:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:04:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:04:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c3ddaea10b3ab04c888331c959287f2ae054541c8a40c4d3131665bbdc1d88ac7a1353e54740e77b6e8fb646c0773b3e793b8b45edf7d479cbc36a71828b8d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9b1d686b03fc8f6eb311342552b421334a45d96b1d0dae13bf6cf476fe2cdd5fbe2b9eb2ab4306f3a3e14dd86916906a026b71a86ac2010bd277d4716153a21"} 17:04:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:04:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:04:35 INFO - Contents: 17:04:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c3ddaea10b3ab04c888331c959287f2ae054541c8a40c4d3131665bbdc1d88ac7a1353e54740e77b6e8fb646c0773b3e793b8b45edf7d479cbc36a71828b8d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9b1d686b03fc8f6eb311342552b421334a45d96b1d0dae13bf6cf476fe2cdd5fbe2b9eb2ab4306f3a3e14dd86916906a026b71a86ac2010bd277d4716153a21"} 17:04:35 INFO - Running post-run listener: copy_logs_to_upload_dir 17:04:35 INFO - Copying logs to upload dir... 17:04:35 INFO - mkdir: /builds/slave/test/build/upload/logs 17:04:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1376.151598 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 56 secs) (at 2016-03-25 17:04:35.486861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 17:04:35.490017) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 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/7c3ddaea10b3ab04c888331c959287f2ae054541c8a40c4d3131665bbdc1d88ac7a1353e54740e77b6e8fb646c0773b3e793b8b45edf7d479cbc36a71828b8d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9b1d686b03fc8f6eb311342552b421334a45d96b1d0dae13bf6cf476fe2cdd5fbe2b9eb2ab4306f3a3e14dd86916906a026b71a86ac2010bd277d4716153a21"} build_url:https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/YtdZDWO4TZik4MSUBi2sfA/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/7c3ddaea10b3ab04c888331c959287f2ae054541c8a40c4d3131665bbdc1d88ac7a1353e54740e77b6e8fb646c0773b3e793b8b45edf7d479cbc36a71828b8d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9b1d686b03fc8f6eb311342552b421334a45d96b1d0dae13bf6cf476fe2cdd5fbe2b9eb2ab4306f3a3e14dd86916906a026b71a86ac2010bd277d4716153a21"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 17:04:35.514613) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:04:35.514913) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1458949013.298572-1628065761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 17:04:35.596141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 17:04:35.596416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 17:04:35.596709) ========= ========= Total master_lag: 0.98 =========