builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1456752394.58 results: success (0) buildid: 20160229044714 builduid: 74c163becf80408b89b56ca152bbb7ac revision: 2fa086d51b6a8d94566493b34cbce00a37af5024 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.579935) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.580433) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.580758) ========= 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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009198 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.610068) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.610390) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.659264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.659551) ========= 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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.736114) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.736473) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.736902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:34.737319) ========= 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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 05:26: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% 54.8K=0.2s 2016-02-29 05:26:36 (54.8 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.318844 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.073666) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.074365) ========= 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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019990 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.126621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.127367) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2fa086d51b6a8d94566493b34cbce00a37af5024 --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 2fa086d51b6a8d94566493b34cbce00a37af5024 --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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 05:26:36,338 truncating revision to first 12 chars 2016-02-29 05:26:36,338 Setting DEBUG logging. 2016-02-29 05:26:36,338 attempt 1/10 2016-02-29 05:26:36,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2fa086d51b6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 05:26:36,719 unpacking tar archive at: fx-team-2fa086d51b6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.842957) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.843369) ========= echo 2fa086d51b6a8d94566493b34cbce00a37af5024 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2fa086d51b6a8d94566493b34cbce00a37af5024'] 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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2fa086d51b6a8d94566493b34cbce00a37af5024 program finished with exit code 0 elapsedTime=0.003719 script_repo_revision: '2fa086d51b6a8d94566493b34cbce00a37af5024' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.891937) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.892274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 05:26:35.906608) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-29 05:26:35.906909) ========= /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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:26:37 INFO - MultiFileLogger online at 20160229 05:26:37 in /builds/slave/test 05:26:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:26:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:37 INFO - {'append_to_log': False, 05:26:37 INFO - 'base_work_dir': '/builds/slave/test', 05:26:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:26:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:37 INFO - 'branch': 'Fx-Team-Non-PGO', 05:26:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:37 INFO - 'config_files': ('talos/linux_config.py',), 05:26:37 INFO - 'default_actions': ('clobber', 05:26:37 INFO - 'read-buildbot-config', 05:26:37 INFO - 'download-and-extract', 05:26:37 INFO - 'populate-webroot', 05:26:37 INFO - 'create-virtualenv', 05:26:37 INFO - 'install', 05:26:37 INFO - 'run-tests'), 05:26:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:37 INFO - 'download_minidump_stackwalk': True, 05:26:37 INFO - 'download_symbols': 'ondemand', 05:26:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:37 INFO - 'installer_path': 'installer.exe', 05:26:37 INFO - 'log_level': 'info', 05:26:37 INFO - 'log_name': 'talos', 05:26:37 INFO - 'log_to_console': True, 05:26:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:26:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:26:37 INFO - 'opt_config_files': (), 05:26:37 INFO - 'pip_index': False, 05:26:37 INFO - 'sps_profile': False, 05:26:37 INFO - 'sps_profile_interval': 0, 05:26:37 INFO - 'suite': 'dromaeojs', 05:26:37 INFO - 'system_bits': '32', 05:26:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:37 INFO - 'title': 'talos-linux64-ix-063', 05:26:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:37 INFO - 'use_talos_json': True, 05:26:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:37 INFO - 'work_dir': 'build'} 05:26:37 INFO - ##### 05:26:37 INFO - ##### Running clobber step. 05:26:37 INFO - ##### 05:26:37 INFO - Running pre-action listener: _resource_record_pre_action 05:26:37 INFO - Running main action method: clobber 05:26:37 INFO - rmtree: /builds/slave/test/build 05:26:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:37 INFO - Running post-action listener: _resource_record_post_action 05:26:37 INFO - ##### 05:26:37 INFO - ##### Running read-buildbot-config step. 05:26:37 INFO - ##### 05:26:37 INFO - Running pre-action listener: _resource_record_pre_action 05:26:37 INFO - Running main action method: read_buildbot_config 05:26:37 INFO - Using buildbot properties: 05:26:37 INFO - { 05:26:37 INFO - "project": "", 05:26:37 INFO - "product": "firefox", 05:26:37 INFO - "script_repo_revision": "production", 05:26:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:26:37 INFO - "repository": "", 05:26:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:26:37 INFO - "buildid": "20160229044714", 05:26:37 INFO - "pgo_build": "False", 05:26:37 INFO - "basedir": "/builds/slave/test", 05:26:37 INFO - "buildnumber": 1474, 05:26:37 INFO - "slavename": "talos-linux64-ix-063", 05:26:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:26:37 INFO - "platform": "ubuntu64_hw", 05:26:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:26:37 INFO - "branch": "fx-team", 05:26:37 INFO - "repo_path": "integration/fx-team", 05:26:37 INFO - "revision": "2fa086d51b6a8d94566493b34cbce00a37af5024", 05:26:37 INFO - "stage_platform": "linux64", 05:26:37 INFO - "builduid": "74c163becf80408b89b56ca152bbb7ac", 05:26:37 INFO - "slavebuilddir": "test" 05:26:37 INFO - } 05:26:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:26:37 INFO - Running post-action listener: _resource_record_post_action 05:26:37 INFO - ##### 05:26:37 INFO - ##### Running download-and-extract step. 05:26:37 INFO - ##### 05:26:37 INFO - Running pre-action listener: _resource_record_pre_action 05:26:37 INFO - Running main action method: download_and_extract 05:26:37 INFO - mkdir: /builds/slave/test/build/tests 05:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:37 INFO - https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/test_packages.json 05:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/test_packages.json 05:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:26:40 INFO - Downloaded 1448 bytes. 05:26:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:26:40 INFO - Using the following test package requirements: 05:26:40 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:26:40 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:26:40 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:26:40 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:40 INFO - u'jsshell-linux-x86_64.zip'], 05:26:40 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:26:40 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:26:40 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:26:40 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:26:40 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:26:40 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:26:40 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:26:40 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:26:40 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:26: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')]} 05:26:40 INFO - https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:26:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:26:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:26:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:26:41 INFO - Downloaded 22057460 bytes. 05:26:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:26:43 INFO - Return code: 0 05:26:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:43 INFO - https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:26:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:26:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:26:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:26:46 INFO - Downloaded 22057460 bytes. 05:26:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:26:47 INFO - Return code: 0 05:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:47 INFO - https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:26:50 INFO - Downloaded 10713410 bytes. 05:26:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:26:50 INFO - Return code: 0 05:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:50 INFO - https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:26:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:26:52 INFO - Downloaded 54839311 bytes. 05:26:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:52 INFO - mkdir: /builds/slave/test/properties 05:26:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:52 INFO - Contents: 05:26:52 INFO - build_url:https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:26:52 INFO - Running post-action listener: _resource_record_post_action 05:26:52 INFO - Running post-action listener: set_extra_try_arguments 05:26:52 INFO - ##### 05:26:52 INFO - ##### Running populate-webroot step. 05:26:52 INFO - ##### 05:26:52 INFO - Running pre-action listener: _resource_record_pre_action 05:26:52 INFO - Running main action method: populate_webroot 05:26:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:52 INFO - '--tppagecycles', 05:26:52 INFO - '7'], 05:26:52 INFO - 'tests': ['tsvgm']}}, 05:26:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:26:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:26:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:52 INFO - 'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:52 INFO - 'tests': ['damp', 'tps']}, 05:26:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:52 INFO - 'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['damp', 'tps']}, 05:26:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:26:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:52 INFO - 'other': {'tests': ['a11yr', 05:26:52 INFO - 'ts_paint', 05:26:52 INFO - 'tpaint', 05:26:52 INFO - 'sessionrestore', 05:26:52 INFO - 'sessionrestore_no_auto_restore']}, 05:26:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['a11yr', 05:26:52 INFO - 'ts_paint', 05:26:52 INFO - 'tpaint', 05:26:52 INFO - 'sessionrestore', 05:26:52 INFO - 'sessionrestore_no_auto_restore']}, 05:26:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['a11yr', 05:26:52 INFO - 'ts_paint', 05:26:52 INFO - 'tpaint', 05:26:52 INFO - 'sessionrestore', 05:26:52 INFO - 'sessionrestore_no_auto_restore']}, 05:26:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['a11yr', 05:26:52 INFO - 'ts_paint', 05:26:52 INFO - 'tpaint', 05:26:52 INFO - 'sessionrestore', 05:26:52 INFO - 'sessionrestore_no_auto_restore']}, 05:26:52 INFO - 'other_l64': {'tests': ['a11yr', 05:26:52 INFO - 'ts_paint', 05:26:52 INFO - 'tpaint', 05:26:52 INFO - 'sessionrestore', 05:26:52 INFO - 'sessionrestore_no_auto_restore']}, 05:26:52 INFO - 'other_nol64': {'tests': ['a11yr', 05:26:52 INFO - 'ts_paint', 05:26:52 INFO - 'tpaint', 05:26:52 INFO - 'sessionrestore', 05:26:52 INFO - 'sessionrestore_no_auto_restore']}, 05:26:52 INFO - 'svgr': {'tests': ['tsvgx', 05:26:52 INFO - 'tsvgr_opacity', 05:26:52 INFO - 'tart', 05:26:52 INFO - 'tscrollx', 05:26:52 INFO - 'cart']}, 05:26:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['tsvgx', 05:26:52 INFO - 'tsvgr_opacity', 05:26:52 INFO - 'tart', 05:26:52 INFO - 'tscrollx', 05:26:52 INFO - 'cart']}, 05:26:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:52 INFO - 'tests': ['tp5o']}, 05:26:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:52 INFO - 'talos_options': ['--e10s'], 05:26:52 INFO - 'tests': ['tp5o']}, 05:26:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:52 INFO - 'talos_options': ['--xperf_path', 05:26:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:52 INFO - 'tests': ['tp5n']}, 05:26:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:52 INFO - 'talos_options': ['--e10s', 05:26:52 INFO - '--xperf_path', 05:26:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:52 INFO - 'tests': ['tp5n']}}, 05:26:52 INFO - 'talos.zip': {'path': '', 05:26:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:52 INFO - Running post-action listener: _resource_record_post_action 05:26:52 INFO - ##### 05:26:52 INFO - ##### Running create-virtualenv step. 05:26:52 INFO - ##### 05:26:52 INFO - Running pre-action listener: _resource_record_pre_action 05:26:52 INFO - Running main action method: create_virtualenv 05:26:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:26:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:52 INFO - Using real prefix '/usr' 05:26:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:55 INFO - Installing pip.................done. 05:26:55 INFO - Return code: 0 05:26:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:26:55 INFO - Using env: {'DISPLAY': ':0', 05:26:55 INFO - 'HOME': '/home/cltbld', 05:26:55 INFO - 'LANG': 'en_US.UTF-8', 05:26:55 INFO - 'LANGUAGE': 'en_US:en', 05:26:55 INFO - 'LOGNAME': 'cltbld', 05:26:55 INFO - 'MAIL': '/var/mail/cltbld', 05:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:55 INFO - 'MOZ_NO_REMOTE': '1', 05:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:55 INFO - 'NO_EM_RESTART': '1', 05:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:55 INFO - 'PWD': '/builds/slave/test', 05:26:55 INFO - 'SHELL': '/bin/bash', 05:26:55 INFO - 'SHLVL': '1', 05:26:55 INFO - 'TERM': 'linux', 05:26:55 INFO - 'TMOUT': '86400', 05:26:55 INFO - 'USER': 'cltbld', 05:26:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:55 INFO - '_': '/tools/buildbot/bin/python'} 05:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:26:55 INFO - Cleaning up... 05:26:55 INFO - Return code: 0 05:26:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:26:55 INFO - Using env: {'DISPLAY': ':0', 05:26:55 INFO - 'HOME': '/home/cltbld', 05:26:55 INFO - 'LANG': 'en_US.UTF-8', 05:26:55 INFO - 'LANGUAGE': 'en_US:en', 05:26:55 INFO - 'LOGNAME': 'cltbld', 05:26:55 INFO - 'MAIL': '/var/mail/cltbld', 05:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:55 INFO - 'MOZ_NO_REMOTE': '1', 05:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:55 INFO - 'NO_EM_RESTART': '1', 05:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:55 INFO - 'PWD': '/builds/slave/test', 05:26:55 INFO - 'SHELL': '/bin/bash', 05:26:55 INFO - 'SHLVL': '1', 05:26:55 INFO - 'TERM': 'linux', 05:26:55 INFO - 'TMOUT': '86400', 05:26:55 INFO - 'USER': 'cltbld', 05:26:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:55 INFO - '_': '/tools/buildbot/bin/python'} 05:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:55 INFO - Downloading/unpacking psutil>=0.7.1 05:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:57 INFO - Installing collected packages: psutil 05:26:57 INFO - Running setup.py install for psutil 05:26:57 INFO - building 'psutil._psutil_linux' extension 05:26:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:26:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:26:58 INFO - building 'psutil._psutil_posix' extension 05:26:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:26:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:58 INFO - Successfully installed psutil 05:26:58 INFO - Cleaning up... 05:26:58 INFO - Return code: 0 05:26:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:26:58 INFO - Using env: {'DISPLAY': ':0', 05:26:58 INFO - 'HOME': '/home/cltbld', 05:26:58 INFO - 'LANG': 'en_US.UTF-8', 05:26:58 INFO - 'LANGUAGE': 'en_US:en', 05:26:58 INFO - 'LOGNAME': 'cltbld', 05:26:58 INFO - 'MAIL': '/var/mail/cltbld', 05:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:58 INFO - 'MOZ_NO_REMOTE': '1', 05:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:58 INFO - 'NO_EM_RESTART': '1', 05:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:58 INFO - 'PWD': '/builds/slave/test', 05:26:58 INFO - 'SHELL': '/bin/bash', 05:26:58 INFO - 'SHLVL': '1', 05:26:58 INFO - 'TERM': 'linux', 05:26:58 INFO - 'TMOUT': '86400', 05:26:58 INFO - 'USER': 'cltbld', 05:26:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:58 INFO - '_': '/tools/buildbot/bin/python'} 05:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:27:00 INFO - Installing collected packages: mozsystemmonitor 05:27:00 INFO - Running setup.py install for mozsystemmonitor 05:27:00 INFO - Successfully installed mozsystemmonitor 05:27:00 INFO - Cleaning up... 05:27:00 INFO - Return code: 0 05:27:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:27:00 INFO - Using env: {'DISPLAY': ':0', 05:27:00 INFO - 'HOME': '/home/cltbld', 05:27:00 INFO - 'LANG': 'en_US.UTF-8', 05:27:00 INFO - 'LANGUAGE': 'en_US:en', 05:27:00 INFO - 'LOGNAME': 'cltbld', 05:27:00 INFO - 'MAIL': '/var/mail/cltbld', 05:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:00 INFO - 'MOZ_NO_REMOTE': '1', 05:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:00 INFO - 'NO_EM_RESTART': '1', 05:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:00 INFO - 'PWD': '/builds/slave/test', 05:27:00 INFO - 'SHELL': '/bin/bash', 05:27:00 INFO - 'SHLVL': '1', 05:27:00 INFO - 'TERM': 'linux', 05:27:00 INFO - 'TMOUT': '86400', 05:27:00 INFO - 'USER': 'cltbld', 05:27:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:00 INFO - '_': '/tools/buildbot/bin/python'} 05:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:03 INFO - Downloading docopt-0.6.1.tar.gz 05:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:03 INFO - Running setup.py install for blobuploader 05:27:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:03 INFO - Running setup.py install for requests 05:27:03 INFO - Running setup.py install for docopt 05:27:03 INFO - Successfully installed blobuploader requests docopt 05:27:03 INFO - Cleaning up... 05:27:03 INFO - Return code: 0 05:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:03 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 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:03 INFO - Using env: {'DISPLAY': ':0', 05:27:03 INFO - 'HOME': '/home/cltbld', 05:27:03 INFO - 'LANG': 'en_US.UTF-8', 05:27:03 INFO - 'LANGUAGE': 'en_US:en', 05:27:03 INFO - 'LOGNAME': 'cltbld', 05:27:03 INFO - 'MAIL': '/var/mail/cltbld', 05:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:03 INFO - 'MOZ_NO_REMOTE': '1', 05:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:03 INFO - 'NO_EM_RESTART': '1', 05:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:03 INFO - 'PWD': '/builds/slave/test', 05:27:03 INFO - 'SHELL': '/bin/bash', 05:27:03 INFO - 'SHLVL': '1', 05:27:03 INFO - 'TERM': 'linux', 05:27:03 INFO - 'TMOUT': '86400', 05:27:03 INFO - 'USER': 'cltbld', 05:27:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:03 INFO - '_': '/tools/buildbot/bin/python'} 05:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:04 INFO - Running setup.py (path:/tmp/pip-BjHnxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:04 INFO - Running setup.py (path:/tmp/pip-iTFLlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:04 INFO - Running setup.py (path:/tmp/pip-wDbXWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:04 INFO - Running setup.py (path:/tmp/pip-NaaIE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:04 INFO - Running setup.py (path:/tmp/pip-96abfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:04 INFO - Running setup.py (path:/tmp/pip-Pl2UyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:04 INFO - Running setup.py (path:/tmp/pip-9CtPwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:04 INFO - Running setup.py (path:/tmp/pip-H5L_zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:04 INFO - Running setup.py (path:/tmp/pip-wY8lDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:04 INFO - Running setup.py (path:/tmp/pip-7rzLyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:04 INFO - Running setup.py (path:/tmp/pip-AmVFDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:04 INFO - Running setup.py (path:/tmp/pip-Hw6Yzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:05 INFO - Running setup.py (path:/tmp/pip-2Plvw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:05 INFO - Running setup.py (path:/tmp/pip-ZFhY_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:05 INFO - Running setup.py (path:/tmp/pip-GmyRBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:05 INFO - Running setup.py (path:/tmp/pip-vBo1wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:05 INFO - Running setup.py (path:/tmp/pip-r5dHXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:05 INFO - Running setup.py install for manifestparser 05:27:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Running setup.py install for mozcrash 05:27:05 INFO - Running setup.py install for mozdebug 05:27:05 INFO - Running setup.py install for mozdevice 05:27:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Running setup.py install for mozfile 05:27:05 INFO - Running setup.py install for mozhttpd 05:27:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:05 INFO - Running setup.py install for mozinfo 05:27:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Running setup.py install for mozInstall 05:27:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Running setup.py install for mozleak 05:27:06 INFO - Running setup.py install for mozlog 05:27:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Running setup.py install for moznetwork 05:27:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Running setup.py install for mozprocess 05:27:06 INFO - Running setup.py install for mozprofile 05:27:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Running setup.py install for mozrunner 05:27:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:06 INFO - Running setup.py install for mozscreenshot 05:27:06 INFO - Running setup.py install for moztest 05:27:07 INFO - Running setup.py install for mozversion 05:27:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:07 INFO - Cleaning up... 05:27:07 INFO - Return code: 0 05:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:07 INFO - Using env: {'DISPLAY': ':0', 05:27:07 INFO - 'HOME': '/home/cltbld', 05:27:07 INFO - 'LANG': 'en_US.UTF-8', 05:27:07 INFO - 'LANGUAGE': 'en_US:en', 05:27:07 INFO - 'LOGNAME': 'cltbld', 05:27:07 INFO - 'MAIL': '/var/mail/cltbld', 05:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:07 INFO - 'MOZ_NO_REMOTE': '1', 05:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:07 INFO - 'NO_EM_RESTART': '1', 05:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:07 INFO - 'PWD': '/builds/slave/test', 05:27:07 INFO - 'SHELL': '/bin/bash', 05:27:07 INFO - 'SHLVL': '1', 05:27:07 INFO - 'TERM': 'linux', 05:27:07 INFO - 'TMOUT': '86400', 05:27:07 INFO - 'USER': 'cltbld', 05:27:07 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:07 INFO - '_': '/tools/buildbot/bin/python'} 05:27:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:07 INFO - Running setup.py (path:/tmp/pip-OfmQkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:07 INFO - Running setup.py (path:/tmp/pip-A6WfWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:07 INFO - Running setup.py (path:/tmp/pip-1ROuqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:07 INFO - Running setup.py (path:/tmp/pip-K30YKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:07 INFO - Running setup.py (path:/tmp/pip-q60UzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:07 INFO - Running setup.py (path:/tmp/pip-_aay8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:07 INFO - Running setup.py (path:/tmp/pip-1ERSBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:07 INFO - Running setup.py (path:/tmp/pip-6IUns3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:07 INFO - Running setup.py (path:/tmp/pip-6Y0huj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:08 INFO - Running setup.py (path:/tmp/pip-ZJYsE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:08 INFO - Running setup.py (path:/tmp/pip-i0rIdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:08 INFO - Running setup.py (path:/tmp/pip-bd_KnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:08 INFO - Running setup.py (path:/tmp/pip-FIUd5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:08 INFO - Running setup.py (path:/tmp/pip-A0DLP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:08 INFO - Running setup.py (path:/tmp/pip-hD_yuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:08 INFO - Running setup.py (path:/tmp/pip-vSH6Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:08 INFO - Running setup.py (path:/tmp/pip-d6i7cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:10 INFO - Downloading blessings-1.6.tar.gz 05:27:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:10 INFO - Installing collected packages: blessings 05:27:10 INFO - Running setup.py install for blessings 05:27:10 INFO - Successfully installed blessings 05:27:10 INFO - Cleaning up... 05:27:10 INFO - Return code: 0 05:27:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:10 INFO - Reading from file tmpfile_stdout 05:27:10 INFO - Current package versions: 05:27:10 INFO - argparse == 1.2.1 05:27:10 INFO - blessings == 1.6 05:27:10 INFO - blobuploader == 1.2.4 05:27:10 INFO - docopt == 0.6.1 05:27:10 INFO - manifestparser == 1.1 05:27:10 INFO - mozInstall == 1.12 05:27:10 INFO - mozcrash == 0.16 05:27:10 INFO - mozdebug == 0.1 05:27:10 INFO - mozdevice == 0.48 05:27:10 INFO - mozfile == 1.2 05:27:10 INFO - mozhttpd == 0.7 05:27:10 INFO - mozinfo == 0.9 05:27:10 INFO - mozleak == 0.1 05:27:10 INFO - mozlog == 3.1 05:27:10 INFO - moznetwork == 0.27 05:27:10 INFO - mozprocess == 0.22 05:27:10 INFO - mozprofile == 0.28 05:27:10 INFO - mozrunner == 6.11 05:27:10 INFO - mozscreenshot == 0.1 05:27:10 INFO - mozsystemmonitor == 0.0 05:27:10 INFO - moztest == 0.7 05:27:10 INFO - mozversion == 1.4 05:27:10 INFO - psutil == 3.1.1 05:27:10 INFO - requests == 1.2.3 05:27:10 INFO - wsgiref == 0.1.2 05:27:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:10 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 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:27:10 INFO - Using env: {'DISPLAY': ':0', 05:27:10 INFO - 'HOME': '/home/cltbld', 05:27:10 INFO - 'LANG': 'en_US.UTF-8', 05:27:10 INFO - 'LANGUAGE': 'en_US:en', 05:27:10 INFO - 'LOGNAME': 'cltbld', 05:27:10 INFO - 'MAIL': '/var/mail/cltbld', 05:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:10 INFO - 'MOZ_NO_REMOTE': '1', 05:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:10 INFO - 'NO_EM_RESTART': '1', 05:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:10 INFO - 'PWD': '/builds/slave/test', 05:27:10 INFO - 'SHELL': '/bin/bash', 05:27:10 INFO - 'SHLVL': '1', 05:27:10 INFO - 'TERM': 'linux', 05:27:10 INFO - 'TMOUT': '86400', 05:27:10 INFO - 'USER': 'cltbld', 05:27:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:10 INFO - '_': '/tools/buildbot/bin/python'} 05:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:27:11 INFO - Cleaning up... 05:27:11 INFO - Return code: 0 05:27:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:27:11 INFO - Using env: {'DISPLAY': ':0', 05:27:11 INFO - 'HOME': '/home/cltbld', 05:27:11 INFO - 'LANG': 'en_US.UTF-8', 05:27:11 INFO - 'LANGUAGE': 'en_US:en', 05:27:11 INFO - 'LOGNAME': 'cltbld', 05:27:11 INFO - 'MAIL': '/var/mail/cltbld', 05:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:11 INFO - 'MOZ_NO_REMOTE': '1', 05:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:11 INFO - 'NO_EM_RESTART': '1', 05:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:11 INFO - 'PWD': '/builds/slave/test', 05:27:11 INFO - 'SHELL': '/bin/bash', 05:27:11 INFO - 'SHLVL': '1', 05:27:11 INFO - 'TERM': 'linux', 05:27:11 INFO - 'TMOUT': '86400', 05:27:11 INFO - 'USER': 'cltbld', 05:27:11 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:11 INFO - '_': '/tools/buildbot/bin/python'} 05:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:11 INFO - Downloading/unpacking jsonschema 05:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:13 INFO - warning: no files found matching '*.txt' 05:27:13 INFO - no previously-included directories found matching 'build' 05:27:13 INFO - no previously-included directories found matching 'dist' 05:27:13 INFO - no previously-included directories found matching '.git*' 05:27:13 INFO - Installing collected packages: jsonschema, functools32 05:27:13 INFO - Running setup.py install for functools32 05:27:13 INFO - warning: no files found matching '*.txt' 05:27:13 INFO - no previously-included directories found matching 'build' 05:27:13 INFO - no previously-included directories found matching 'dist' 05:27:13 INFO - no previously-included directories found matching '.git*' 05:27:13 INFO - Successfully installed jsonschema functools32 05:27:13 INFO - Cleaning up... 05:27:13 INFO - Return code: 0 05:27:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:13 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 0x7f4d9b17af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c63b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, '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': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:27:13 INFO - Using env: {'DISPLAY': ':0', 05:27:13 INFO - 'HOME': '/home/cltbld', 05:27:13 INFO - 'LANG': 'en_US.UTF-8', 05:27:13 INFO - 'LANGUAGE': 'en_US:en', 05:27:13 INFO - 'LOGNAME': 'cltbld', 05:27:13 INFO - 'MAIL': '/var/mail/cltbld', 05:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:13 INFO - 'MOZ_NO_REMOTE': '1', 05:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:13 INFO - 'NO_EM_RESTART': '1', 05:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:13 INFO - 'PWD': '/builds/slave/test', 05:27:13 INFO - 'SHELL': '/bin/bash', 05:27:13 INFO - 'SHLVL': '1', 05:27:13 INFO - 'TERM': 'linux', 05:27:13 INFO - 'TMOUT': '86400', 05:27:13 INFO - 'USER': 'cltbld', 05:27:13 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:13 INFO - '_': '/tools/buildbot/bin/python'} 05:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:13 INFO - Downloading/unpacking flake8 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:27:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:27:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:27:16 INFO - no previously-included directories found matching 'docs/_build' 05:27:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:27:16 INFO - Running setup.py install for pep8 05:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:27:16 INFO - no previously-included directories found matching 'docs/_build' 05:27:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:27:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:27:16 INFO - Cleaning up... 05:27:16 INFO - Return code: 0 05:27:16 INFO - Running post-action listener: _resource_record_post_action 05:27:16 INFO - Running post-action listener: _start_resource_monitoring 05:27:16 INFO - Starting resource monitoring. 05:27:16 INFO - ##### 05:27:16 INFO - ##### Running install step. 05:27:16 INFO - ##### 05:27:16 INFO - Running pre-action listener: _resource_record_pre_action 05:27:16 INFO - Running main action method: install 05:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:16 INFO - Reading from file tmpfile_stdout 05:27:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:16 INFO - Reading from file tmpfile_stdout 05:27:16 INFO - Output received: 05:27:16 INFO - Usage: mozinstall [options] installer 05:27:16 INFO - Options: 05:27:16 INFO - -h, --help show this help message and exit 05:27:16 INFO - -d DEST, --destination=DEST 05:27:16 INFO - Directory to install application into. [default: 05:27:16 INFO - "/builds/slave/test"] 05:27:16 INFO - --app=APP Application being installed. [default: firefox] 05:27:16 INFO - mkdir: /builds/slave/test/build/application 05:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:27:32 INFO - Reading from file tmpfile_stdout 05:27:32 INFO - Output received: 05:27:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:27:32 INFO - Running post-action listener: _resource_record_post_action 05:27:32 INFO - ##### 05:27:32 INFO - ##### Running run-tests step. 05:27:32 INFO - ##### 05:27:32 INFO - Running pre-action listener: _resource_record_pre_action 05:27:32 INFO - Running main action method: run_tests 05:27:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:32 INFO - Python 2.7.3 05:27:32 INFO - Return code: 0 05:27:32 INFO - grabbing minidump binary from tooltool 05:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:32 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 0x2455100>, '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 0x2456000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2456490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:27:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:27:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:32 INFO - Return code: 0 05:27:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:27:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:27:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:27:33 INFO - Return code: 0 05:27:33 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/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:27:33 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/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:27:33 INFO - Using env: {'DISPLAY': ':0', 05:27:33 INFO - 'HOME': '/home/cltbld', 05:27:33 INFO - 'LANG': 'en_US.UTF-8', 05:27:33 INFO - 'LANGUAGE': 'en_US:en', 05:27:33 INFO - 'LOGNAME': 'cltbld', 05:27:33 INFO - 'MAIL': '/var/mail/cltbld', 05:27:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:33 INFO - 'MOZ_NO_REMOTE': '1', 05:27:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:33 INFO - 'NO_EM_RESTART': '1', 05:27:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:33 INFO - 'PWD': '/builds/slave/test', 05:27:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:33 INFO - 'SHELL': '/bin/bash', 05:27:33 INFO - 'SHLVL': '1', 05:27:33 INFO - 'TERM': 'linux', 05:27:33 INFO - 'TMOUT': '86400', 05:27:33 INFO - 'USER': 'cltbld', 05:27:33 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259', 05:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:33 INFO - '_': '/tools/buildbot/bin/python'} 05:27:33 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/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:27:34 INFO - mozversion application_buildid: 20160229044714 05:27:34 INFO - mozversion application_changeset: 2fa086d51b6a8d94566493b34cbce00a37af5024 05:27:34 INFO - mozversion application_display_name: Nightly 05:27:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:34 INFO - mozversion application_name: Firefox 05:27:34 INFO - mozversion application_remotingname: firefox 05:27:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:27:34 INFO - mozversion application_vendor: Mozilla 05:27:34 INFO - mozversion application_version: 47.0a1 05:27:34 INFO - mozversion platform_buildid: 20160229044714 05:27:34 INFO - mozversion platform_changeset: 2fa086d51b6a8d94566493b34cbce00a37af5024 05:27:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:27:34 INFO - mozversion platform_version: 47.0a1 05:27:34 INFO - using testdate: 1456752454 05:27:34 INFO - actual date: 1456752454 05:27:34 INFO - starting webserver on 'localhost:41034' 05:27:34 INFO - SUITE-START | Running 2 tests 05:27:34 INFO - TEST-START | dromaeo_css 05:27:34 INFO - operating with platform_type : linux_ 05:27:34 INFO - Initialising browser for dromaeo_css test... 05:27:34 INFO - TEST-INFO | started process 26748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEHPR_/profile http://localhost:41034/getInfo.html) 05:27:38 INFO - PROCESS | 26748 | __metrics Screen width/height:1600/1200 05:27:38 INFO - PROCESS | 26748 | colorDepth:24 05:27:38 INFO - PROCESS | 26748 | Browser inner width/height: 1024/697 05:27:38 INFO - PROCESS | 26748 | __metrics 05:27:39 INFO - PROCESS | 26748 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:27:39 INFO - PROCESS | 26748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:27:39 INFO - PROCESS | 26748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:27:39 INFO - PROCESS | 26748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:27:39 INFO - PROCESS | 26748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:27:39 INFO - PROCESS | 26748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:27:39 INFO - PROCESS | 26748 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:27:39 INFO - PROCESS | 26748 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:27:40 INFO - TEST-INFO | 26748: exit 0 05:27:40 INFO - Browser initialized. 05:27:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:27:40 INFO - TEST-INFO | started process 26841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEHPR_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:52 INFO - PROCESS | 26841 | RSS: Main: 153116672 05:27:52 INFO - PROCESS | 26841 | 05:28:43 INFO - PROCESS | 26841 | 1456752523374 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:30:54 INFO - PROCESS | 26841 | Cycle 1(1): loaded http://localhost:41034/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41034/tests/dromaeo/cssquery-ext.html) 05:30:55 INFO - PROCESS | 26841 | RSS: Main: 242475008 05:30:55 INFO - PROCESS | 26841 | 05:33:58 INFO - PROCESS | 26841 | Cycle 1(1): loaded http://localhost:41034/tests/dromaeo/cssquery-ext.html (next: http://localhost:41034/tests/dromaeo/cssquery-jquery.html) 05:33:58 INFO - PROCESS | 26841 | RSS: Main: 232742912 05:33:58 INFO - PROCESS | 26841 | 05:37:00 INFO - PROCESS | 26841 | Cycle 1(1): loaded http://localhost:41034/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41034/tests/dromaeo/cssquery-mootools.html) 05:37:00 INFO - PROCESS | 26841 | RSS: Main: 232730624 05:37:00 INFO - PROCESS | 26841 | 05:40:02 INFO - PROCESS | 26841 | Cycle 1(1): loaded http://localhost:41034/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41034/tests/dromaeo/cssquery-prototype.html) 05:40:03 INFO - PROCESS | 26841 | RSS: Main: 218488832 05:40:03 INFO - PROCESS | 26841 | 05:43:06 INFO - PROCESS | 26841 | Cycle 1(1): loaded http://localhost:41034/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41034/tests/dromaeo/cssquery-yui.html) 05:43:06 INFO - PROCESS | 26841 | RSS: Main: 195465216 05:43:06 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | Cycle 1(1): loaded http://localhost:41034/tests/dromaeo/cssquery-yui.html (next: http://localhost:41034/tests/dromaeo/cssquery-dojo.html) 05:46:09 INFO - PROCESS | 26841 | RSS: Main: 273551360 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | __start_tp_report 05:46:09 INFO - PROCESS | 26841 | _x_x_mozilla_page_load 05:46:09 INFO - PROCESS | 26841 | _x_x_mozilla_page_load_details 05:46:09 INFO - PROCESS | 26841 | |i|pagename|runs| 05:46:09 INFO - PROCESS | 26841 | |0;dojo.html;2571.987140064299;2629.184952664673;2629.329520972152;2640.4455064436465;2659.8803053862575;4427;4480.171168333861;4513.413256276684;4517.186906356855;4526.321051842226;4533.184026875161;4549.931751023737;4560.97719511402;4588.724676519411;4668.346431499593;4070.3487442009286;4129.938050929239;4132.5040995080635;4137.689673274516;4168.083021735221;4076.082881351702;4151.00375909781;4153.210889930919;4164.625183733463;4224.72539284947;4055.71609987301;4120.855770048064;4174.749515029108;4231.836245032609;4247.957520424787;4158.8336466541305;4178.456800615931;4184.665226781881;4216.198922204771;4223.683223758199;4006.338954072604;4131.958680413218;4153.771542565158;4155.23128221277;4192.035831758682;4376.671749618791;4403.515613282536;4435.8225670973125;4447.444069491314;4456.665750068758;4871.050145221683;4881.585065269456;4883.316335713003;4887.511248875119;4893.804247830082;4673.252279635242;4852.902941941176;4884.072026315024;4905.043516514281;4906.484819093979;4569.246074397754;4571.839985600488;4573.039661671053;4577.038821847383;4618.422697162889;4971.030649023406;5000.648657279469;5015.14742493777;5017.096922553976;5058.317127187856;4579.335996280521;4644.883877903012;4793.688410253322;4806.759662016885;4815.061063092733;4853.6602437829715;4863.440704318978;4867.902641947141;4886.633502487328;4912.263160525949;4797.424309082862;4832.95167048332;4833.830815921426;4834.468208497063;4871.683340582851;4607.516210797885;4775.95224047762;4795.352627395257;4852.8786780330065;4876.414830220397;4060.9187816244103;4082.530508991504;4085.3667681509414;4100.200460910153;4105.548389677133;3590.9461358079648;3591.838367273479;3601.513795637555;3607.8196090195383;3627.220147668211;4031.8387264509092;4104.8768536943935;4196.538380778112;4251.979524914061;4256.702030857872;4872.561469467694;4882.36529251195;4904.0191961607825;4913.70517768935;4927.088488629615;4195.056112374752;4202.558731333227;4204.159168166379;4223.957760422357;4260.020195355024;4131.5042194936195;4288.742675439484;4345.109252603209;4366.585174408489;4383.912321753547;4574.176648203355;4574.931376029363;4593.747343896118;4594.2419500783335;4635.791389387486;4631.698939568917;4852.611791056636;4856.1987272099705;4860.270959356125;4890.095332363524;4524.954750452585;4532.252178390529;4578.88552786183;4580.725156490621;4595.609373203181;4761.40482439695;4797.328374027708;4798.136335459651;4800.35195248637;4823.517648235148;4584.724916504887;4802.399700037496;4870.926936095891;4876.634252431153;4889.071076495455;4729.266963620645;4732.077244937204;4744.572988431058;4749;4788.784504697367;4719.622430205644;4735.289706544046;4737.810487580458;4780.689255198401;4784.641151913551;4545.454545454567;4584.793684284282;4660.231061874752;4664.090502352009;4665.440147182359;4726.196546587157;4742.810287588458;4747.454042785124;4753.595944344631;4769.2130798417875;4647.419072615923;4648.883777905444;4649.386084583902;4649.86050418488;4682.063587282489 05:46:09 INFO - PROCESS | 26841 | |1;ext.html;482.594620518764;493.1714719271623;494.7031780931444;503.5392615756583;525.3039722367862;24638.26085217444;35070.64929350706;35633.2873342533;35662.99999999997;35687.643123568756;40402;40923.59076409235;40925;41108;41112;6802.489813264;7729.806754831118;7914.3272821810215;7927.762167134995;7928.04863416388;6804.965975170117;6894.448444124458;9878.901210987906;10081.596736130547;10092.646757363495;9780.168685661727;9882.258830587698;9891.357061790997;9894.703158905244;9909.157721593674;9672.709818705414;9720.125188732978;9733.805323893554;9739.318247722662;9752.122308992224;9875.358101723437;10166.08505234525;10166.237532185116;10170.186385089175;10173.389596624153;34478.482822757425;35045.474317885;35079.64920350789;35092.824535877415;35106.77126300567;2707.296103013211;2720.9591856122174;2832.362718388367;3505.91235219119;3590.0486371111674;28694;28753.85623071892;29044.709552904413;29149.417011659647;29169.270768230752;2923.298408381973;2927.34134819666;2967.5697023931625;2985.4177286038434;3006.744426723731;225411;227053;227388;227405;228315;56315.15527267094;56913.71543142258;57095.42904570984;57116;57284.427155727906;60419;60940.39059609347;61459.70294010341;61496;61583.6920815393;11446;11590.304581724955;11590.304581725124;11598.536058557564;11603.361815100081;8238.09380968093;9630.807383852283;9638.228941684789;9726.36778609388;9732.2214222862;19345.613087738166;19455;19683.31108411199;19683.606327873364;19724.802751972584;7172.49792514519;7426.702931882664;7525.661345239478;7534.64376412251;7554;846.7586737779703;860.7805009722481;881.3389957531851;907.3376435202339;1016.8983101689772;26386.86806565993;26951.460970780867;27421.862890685417;27463.450730985267;27521.17436476909;995.5569771451635;1000.479750529735;1001.1190152665753;1041.3023274406014;1101.713554475842;13823.377947992365;14071.788923166161;14100.717985640229;14321.427142914166;14364.928175359057;256861;260652;260986;261484;261547;45935.77032114818;46442;46479.76760116178;46515.30227046597;46541.30188047182;1061.5117046158698;1171.6719318590638;1180.8760080191628;1182.361524776611;1221.7190046289224;24700.25899223026;26517.734822651528;26872.865635671697;26880.462390751683;26943.595846061933;36553.268934621694;36851.81574092113;36910.8154459226;36918.815405922796;36978;152854;153448.23275883548;153488;153697;153861;23320.416989575395;28114;28747.712522874503;28868.855655721585;28900.132996010154;33817.83091084529;41321.586784132975;41583.58416415918;42611.3608295882;42662;34547;35107.473387899714;36470.08824779402;36531.634683652825;36586.8170659145;32222.677773221967;33765.83117084399;33878.66121338755;34108;34188.658113419544;33806.49290260697;33889.83055084709;34050.489242660886;34374.656253438145;34557.654423455446;29847.403051939273;30328.84835575808;30338.089857304316;30355.696443035285;30398.54402184013;23247.651285231073;23800.88099559491;24061.879690601436;24104;24169.395765106012 05:46:09 INFO - PROCESS | 26841 | |2;jquery.html;337.84121462912435;337.9966200337996;342.34441045398063;342.3597871979398;344.57272981502945;14243.92878035611;15096.924515377435;15638.765418518717;16302.673946521092;16305.347786088541;14742.705145897102;14856.777148342757;15115.546533604009;15696.13671248081;15709.371625134982;4894.975525122379;5083.771230294646;5094.719790411545;5096.541311281984;5103;4909.0672772173175;4944.728039957801;5038.672486288379;5043.747812609373;5117.820876269331;5023.924641130386;5034.949650503485;5043.798248070073;5050.747462626854;5069.315642388286;4887.315775791392;4964.925526117093;5002.774875130628;5008.724520151391;5030.295758593781;4457.777111144463;4474.798634061475;4475.1944649963;4487.439070116236;4500.077484115781;18776.71834922477;19186.13662385196;19545;19551.511212219666;19556.608867822564;1875.7842848072373;1944.931927382549;2047.2425202674956;2446.2905757330354;2514.446821699223;11967.94016029923;12379.814302785466;12419.875801241962;12714.682132946658;12891.16207446513;1751.1944505527472;1775.4673597920573;1781.9287228510843;1810.2577943043289;1858.0709645177412;53013.204801928005;53355.466445335434;53387;54033.459665403236;54753.45246547523;9028.187463128219;9075.273978081737;9234.86147707785;9241.399309044891;9404.576794044284;12215.26708397499;12316.876831231752;12340.938295308466;12347.62957111288;12356.443960021821;6757.155355580552;6850;6850.45196384298;6958.095447591781;6971.3028697129885;6423.100765892778;6456.451201647913;6506.577072490368;6550.115734375893;6612.471002319803;5732.022452253966;5779.88440231193;5792.275965504312;5840.649561026352;5854.912176317359;1678.9496315110566;1701.387500499819;1741.747446620233;1755.297361559311;1767.8320559546823;858.4420126917429;890.6615486115235;958.1999030809213;958.3339578992673;972.9659461918799;15532.534023979299;15759.818182722403;15985.920070399807;16048.679026419406;16289.755653665205;869.4870026684287;879.3624622148891;905.959231834569;924.0805398628407;929.2705226397246;6918.163552943269;9351.205147562534;9405.76485587852;9430.622775089058;9578.090081442251;264579;269254;270960;271430;367761;64554;64850;65950;67174.32825671778;68009.65995169993;906.7914379692708;929.4934260827865;947.7346343023964;949.0651708067548;988.6342053440274;14228.715425691635;14546.345414456586;14668.706625867637;14703.3383497745;14902.105873647182;30187.849060754557;30832.229194270323;31109;31402.21494462657;31502.36995260128;40990.385144222266;43632.34551481667;43946.560534394244;44796.32805507855;44838.55161448344;6840.828979275558;6853.4859885507785;7002.824929376602;7067;7098.3256590623805;7781.377489800916;9844.96627854065;9917.752056198653;9940.900590994286;10255.58977640886;8974.685885993958;9084.273258139465;9316.720498385059;9581.760455988657;9653.082957119062;9102.453852768855;9185.265178785814;9717.319787614799;9817;9905.108540231413;8904.955475222583;9152;9931.801363972536;10070.546825392728;10077.69766906994;6898.275681053417;7024.824379390556;7068.9293107070325;7075.646217689198;7091.361777440055;8634.654613815628;9246.398984066283;9337.813243734952;9460.905390946278;9727.173190278623 05:46:09 INFO - PROCESS | 26841 | |3;mootools.html;1172.7185475485885;1357.151780137414;1363.100353766514;1471.39672734179;1715.9056251906147;5939.673317967516;6828.897566536506;6988.056612357343;7005.894911576331;7006.439484841219;6929.965350173255;7086.964565177167;7091.11361079865;7096.609686467243;7097.85804283914;1686.1147897353865;1748.7814023247095;1751.5008222656545;2044.94887627809;2079.9584008319825;2055.4142069510194;2101.873887566743;2102.6951092091635;2103.2743703422293;2109.4093653776968;2038.8572799904014;2058.7220725202133;2066.8346532277383;2068.88621125838;2072.129705523676;2012.3359291433865;2016.8084032016934;2017.4552870724895;2019.5758890632985;2023.4840115770385;2027.9391618251475;2065.473304307407;2122.490602255463;2123.7239158909397;2127.5425783456476;7239.746608868717;7289.416846652255;7290.489665723401;7296.708131674726;7305.598192099433;4275.315949448073;4351.999040220735;4373.671974601918;4401.977990110029;4419.292913133883;2619.698734645521;2660.720624334456;2699.2307192450057;2758.4207316463367;2769.0446795855396;816.4488969945263;830.2735106781566;839.106351735406;859.862422012475;863.0765081362944;9874.111329980336;9896.802063958752;9934.602615895355;9972.301938864282;9981.401115933068;3810.5236845394325;3983.541892682321;4018.9196216075516;4033.394990751352;4047.9392809107885;8445.57772111392;8480.236778689947;8484.363672724447;8484.53335066565;8496.53269070207;4350.73895566267;4362.083962367875;4368.956310436918;4376.234159022222;4385.079133381962;3203.2952750394875;3638.0904773806546;3689.3912504437003;3902.043999220209;3902.453656488094;3409.829508524564;3433.7424693148114;3459.9308013840086;3472.2013936794174;3478.6347433519622;1105.2760441910561;1114.3815182573587;1115.7880002799443;1122.1079242002627;1123.5898896902736;1135.9659210223706;1140.7946569617382;1148.4544841200363;1155.9537618495335;1167.4688016952266;6587.473002159816;6744.629045402452;6772.69522871472;6833.043373927654;6842.5552339098795;408.43023981545576;411.7200303793449;412.13451751322583;413.7682897577366;414.3929143804341;5021.121303771898;5040.84877453677;5240.292560504359;5265;5297.735113244399;8357.707480238285;8613.870791938127;8680.175383338572;8692.087330830173;8697.826043479221;8423.241908228289;8567.485950842969;8617.69838055665;8627.568621568897;8643.567821608895;6821.488388370892;6878.243393226741;6901.240863505011;6949.965250173716;6966.756163534354;6491;6534.607923524603;6588.8352791180605;6615.404613584608;6619.139511863427;7255;7493.363064139609;7910.248526389983;7935.246151615587;8004.959975200087;7491.250874912465;7731.458797884319;7744.225577442436;7782.338501227459;7788.7663370096725;5188.092083885381;6003.609765365237;6041.365656605993;6095.51235901118;6106.45041946227;6738.191417029988;6811.4550835934;6830.521863469509;6843.555168914005;6843.863122737418;5892.882142357214;5925.259342582177;6004.189434426296;6061.15143879866;6067.059605761114;5865.149553314831;5930.140129681258;5993.760249589967;5999.610025348338;6001.609895356963;6247.96876015617;6403.359664033559;6421.293657697743;6425.807225783234;6443.291237963726;5964.463198312173;5969.970150149222;5982.820515384546;5985.790497332572;5988.161657368059;5937.465628093492;5966.552508561962;5993.850153746192;5999.70001499932;6028.939710602838 05:46:09 INFO - PROCESS | 26841 | |4;prototype.html;292.58160830013077;298;300.3003003003003;304.9252933031408;305.43646971337876;5265.815696450625;5370.892582148354;5395.946040539593;5409.486098820616;5447.291852059237;5189.377274727029;5226.947730522703;5264.6051546134;5274.05067087924;5275.551578115865;3892.3188442022674;3997.2804895118866;3998.900027499307;4121.711480196387;4129.236091323108;4019.0153412414;4030.314846476106;4041.737287076345;4101.52832424272;4130.690198235129;4071.7760523171214;4076.979615101935;4084.4077608746716;4085.4893138357706;4085.6527195188446;4082.5100987881347;4087.305158123111;4105.568915263884;4119.423280740699;4122.216778812016;3354.681305275995;3500.94748578769;3544.7873127612424;3549.698275646573;3602.0274525877867;5122.948770512285;5140.871478213037;5156.994386094713;5158.53573178412;5163.870903227449;4752.049590081998;4752.477227504972;4752.7861246244;4755.881102972418;4763;5591.10542313228;5592.049351610236;5600.467955544217;5604.859878503029;5605.5515558755205;3955.940660890089;3957.584453632356;3961.564227934925;3963.801809909493;3967.7222594418404;5738.741756620921;5810.854728631776;5811.738471768781;5901.527877769769;5906.700525884298;4064.898377540585;4093.0585965228165;4095.692823038284;4098.73358231714;4102.200070986189;4134.131832315247;4135.359019352005;4136.937945930814;4139.79301034947;4142.689298302639;4714.976425117852;4715.57559819611;4716.151092803259;4720.787564559603;4727.787249573777;5595.748191331319;5609.719514024282;5615.719214039282;5615.792604590033;5617.38208797032;1435.7415665180158;1472.8453512381259;1473.668424604477;1474.3586539855198;1474.9852501475063;963.1043129889131;989.5843745626854;1001.2540657210279;1003.5835128421769;1023.0179028133076;4747.976260118747;4851.223804191312;4926.876828079255;4945.159322915113;4948.257761335828;5824;5826.126081087871;5898.793542226087;5918.437748413894;5931.1992880960515;4967.677100988424;4969.35398398206;4970.2296144097;4977.427595826454;4978.4025916890205;3104.6584875663657;3130.686931306851;3146.8741250350186;3148.1499995001677;3150;5559.8880223955375;5584.385717571064;5588.776448942078;5612.5229355504425;5616;5833.358330583633;5992.490638295793;6026.397360264026;6028.517718582503;6038.365971573009;5528.226048353234;5553.278073850535;5553.916691249554;5555.805546805843;5557.666540007532;5856.736446859987;5865.384134665798;5868.4424979626865;5868.94131058684;5870.618409803349;5742.626729262584;5745.166950792028;5751.396103409082;5757.9424205757405;5758.3090029196765;5540.418256083053;5545.417731138173;5546.223528705904;5550.306211723535;5551.722413879371;3788.2991646544374;3945.7040721945395;4105.794710264415;4108.055147316074;4109.732867363612;5811.302643682785;5812.883742325045;5832.50423713989;5834.124881267844;5836.358000619844;5601.5238704710555;5602.3837377887585;5608.38307786135;5611.831645050655;5618.129189975561;5583.637063590853;5597.720113994365;5607.943920560742;5607.990561698934;5621.5221706155435;5490.121580547253;5491.588130890279;5494.203340515683;5500.862478438071;5502.669839809464;5463.508284254436;5632.408597097246;5651.15232715096;5657;5658.066419040977;5493.615446918678;5493.945060549503;5513.3108361454815;5513.393526712139;5515.917261241165 05:46:09 INFO - PROCESS | 26841 | |5;yui.html;590.2347501953349;715.0482905876802;738.3945164964728;739.8705226585346;751.3688501658605;10555.577776888926;10721.35671859689;10725.78548429032;10845.783084338309;10878.728031799208;9751;10966.451677416137;11014.118870490362;11037.83443248352;11038.668839934795;755.0750330844726;758.2190343945717;768.5503980171607;768.8885111658806;770.2451597434517;756.6670664907423;761.5164370624638;762.3520007993217;762.4396068889362;762.5158024654329;789.5657388436366;799.7161007842219;799.7880561651167;800.1638287989066;800.6637212370789;792.0614072324286;792.6789650191681;792.9484583502054;793.5516433215244;793.849168657956;590.4272855330323;593.8218534439694;594.349187639534;594.8869714754182;595.5325069820213;9976.152027077707;9977.451240181786;9991.850122248172;10013.699589012342;10042.497875106288;9571.664991725256;9907.405555666683;9946.055124763136;10139.898601013969;10203.183745300432;10345.741356466073;10690.358578485315;10717.426059152725;10887.183461240438;10889.564417423293;3184.538241954927;3214.292855571794;3215.26049008727;3248.3990461764647;3278.541004259406;36011.279774404626;38884;40557.18885622271;40607.59392406097;41825.58174418248;8377;8396;8412.789680258042;8422.957885210535;8451.788705282293;14597.19715415641;14621.049631774113;14650.560483185522;16071.11608861524;16235.188240587924;6518.054882042172;6583.637899915455;6689.397954184147;6713.932860671429;6747.190337159573;3655;3729.0490924814;3757.4176002719623;3838.596947320547;3861.4014827701753;2561.3468565515673;2588.6634737484005;2595.1046888823703;2602.193320070784;2608.3348746069632;454.137139435076;471.0273285665091;476.18096873378425;479.5516192360154;484.85939077667786;541.5180489364469;555.4029418375263;561.9634723742944;570.4979617936273;576.5042063825107;6816.693248803816;7242.203357630657;7296;7347.105829269598;7623.123340815766;581.7120525339984;583.6177303865975;589.5224867857049;602.9939700602938;608.5466327585976;3299.818509981974;3368.9326213475592;3476.8261586920553;3545.964540354615;3594.0835087052633;47041.764791175825;47271.29093063607;48136;48142.75928620334;48418.75790621095;43468.565314347084;43515.78242108769;43853.34219986703;44469;44728.77635611801;33085.338293234;33413;38588.421173682415;38696.80651596724;39610.60389396127;7720.922790772245;7882.487638303722;7936.56348900816;8014.599270036591;8244.752657420288;30201.697983020767;30208.84895575596;30447.847760761055;30777.538336925412;30955.69044309528;34161.31677366389;37674.246515070095;37748.43377349287;37927;39923.40114898337;9539.427634341962;9893.258005649748;10175.949120254352;10302.124319432933;10574.682759517227;8364.53995030255;10626.574937002433;10665.520051597541;10917.727056823325;11301.434928253719;9843.836174557646;10284.588616455258;10310.845337320095;10363.84454233172;10403.479826008821;9989.100980911753;10263.332883362558;10334.741631459274;10356.378617282988;10363.274570779973;10008.899911000797;10465.843012354668;10562.524686388977;10610.363378197333;10617.309874858109;8161.79595510117;8395.202455766692;8430.873536896828;8449;8494.490330580185;8562.657493700182;8698.717885056618;8781.604827782892;8914.286857051291;9111.589978450853 05:46:09 INFO - PROCESS | 26841 | __end_tp_report 05:46:09 INFO - PROCESS | 26841 | __start_cc_report 05:46:09 INFO - PROCESS | 26841 | _x_x_mozilla_cycle_collect,861 05:46:09 INFO - PROCESS | 26841 | __end_cc_report 05:46:09 INFO - PROCESS | 26841 | __startTimestamp1456753569613__endTimestamp 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | ------- Summary: start ------- 05:46:09 INFO - PROCESS | 26841 | Number of tests: 6 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | [#0] dojo.html Cycles:165 Average:4479.31 Median:4588.72 stddev:462.19 (10.1%) stddev-sans-first:438.72 05:46:09 INFO - PROCESS | 26841 | Values: 2572.0 2629.2 2629.3 2640.4 2659.9 4427.0 4480.2 4513.4 4517.2 4526.3 4533.2 4549.9 4561.0 4588.7 4668.3 4070.3 4129.9 4132.5 4137.7 4168.1 4076.1 4151.0 4153.2 4164.6 4224.7 4055.7 4120.9 4174.7 4231.8 4248.0 4158.8 4178.5 4184.7 4216.2 4223.7 4006.3 4132.0 4153.8 4155.2 4192.0 4376.7 4403.5 4435.8 4447.4 4456.7 4871.1 4881.6 4883.3 4887.5 4893.8 4673.3 4852.9 4884.1 4905.0 4906.5 4569.2 4571.8 4573.0 4577.0 4618.4 4971.0 5000.6 5015.1 5017.1 5058.3 4579.3 4644.9 4793.7 4806.8 4815.1 4853.7 4863.4 4867.9 4886.6 4912.3 4797.4 4833.0 4833.8 4834.5 4871.7 4607.5 4776.0 4795.4 4852.9 4876.4 4060.9 4082.5 4085.4 4100.2 4105.5 3590.9 3591.8 3601.5 3607.8 3627.2 4031.8 4104.9 4196.5 4252.0 4256.7 4872.6 4882.4 4904.0 4913.7 4927.1 4195.1 4202.6 4204.2 4224.0 4260.0 4131.5 4288.7 4345.1 4366.6 4383.9 4574.2 4574.9 4593.7 4594.2 4635.8 4631.7 4852.6 4856.2 4860.3 4890.1 4525.0 4532.3 4578.9 4580.7 4595.6 4761.4 4797.3 4798.1 4800.4 4823.5 4584.7 4802.4 4870.9 4876.6 4889.1 4729.3 4732.1 4744.6 4749.0 4788.8 4719.6 4735.3 4737.8 4780.7 4784.6 4545.5 4584.8 4660.2 4664.1 4665.4 4726.2 4742.8 4747.5 4753.6 4769.2 4647.4 4648.9 4649.4 4649.9 4682.1 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | [#1] ext.html Cycles:180 Average:38264.59 Median:33970.16 stddev:56866.99 (167.4%) stddev-sans-first:56955.75 05:46:09 INFO - PROCESS | 26841 | Values: 482.6 493.2 494.7 503.5 525.3 24638.3 35070.6 35633.3 35663.0 35687.6 40402.0 40923.6 40925.0 41108.0 41112.0 6802.5 7729.8 7914.3 7927.8 7928.0 6805.0 6894.4 9878.9 10081.6 10092.6 9780.2 9882.3 9891.4 9894.7 9909.2 9672.7 9720.1 9733.8 9739.3 9752.1 9875.4 10166.1 10166.2 10170.2 10173.4 34478.5 35045.5 35079.6 35092.8 35106.8 2707.3 2721.0 2832.4 3505.9 3590.0 28694.0 28753.9 29044.7 29149.4 29169.3 2923.3 2927.3 2967.6 2985.4 3006.7 225411.0 227053.0 227388.0 227405.0 228315.0 56315.2 56913.7 57095.4 57116.0 57284.4 60419.0 60940.4 61459.7 61496.0 61583.7 11446.0 11590.3 11590.3 11598.5 11603.4 8238.1 9630.8 9638.2 9726.4 9732.2 19345.6 19455.0 19683.3 19683.6 19724.8 7172.5 7426.7 7525.7 7534.6 7554.0 846.8 860.8 881.3 907.3 1016.9 26386.9 26951.5 27421.9 27463.5 27521.2 995.6 1000.5 1001.1 1041.3 1101.7 13823.4 14071.8 14100.7 14321.4 14364.9 256861.0 260652.0 260986.0 261484.0 261547.0 45935.8 46442.0 46479.8 46515.3 46541.3 1061.5 1171.7 1180.9 1182.4 1221.7 24700.3 26517.7 26872.9 26880.5 26943.6 36553.3 36851.8 36910.8 36918.8 36978.0 152854.0 153448.2 153488.0 153697.0 153861.0 23320.4 28114.0 28747.7 28868.9 28900.1 33817.8 41321.6 41583.6 42611.4 42662.0 34547.0 35107.5 36470.1 36531.6 36586.8 32222.7 33765.8 33878.7 34108.0 34188.7 33806.5 33889.8 34050.5 34374.7 34557.7 29847.4 30328.8 30338.1 30355.7 30398.5 23247.7 23800.9 24061.9 24104.0 24169.4 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | [#2] jquery.html Cycles:180 Average:20018.63 Median:5047.27 stddev:48225.14 (955.5%) stddev-sans-first:48337.79 05:46:09 INFO - PROCESS | 26841 | Values: 337.8 338.0 342.3 342.4 344.6 14243.9 15096.9 15638.8 16302.7 16305.3 14742.7 14856.8 15115.5 15696.1 15709.4 4895.0 5083.8 5094.7 5096.5 5103.0 4909.1 4944.7 5038.7 5043.7 5117.8 5023.9 5034.9 5043.8 5050.7 5069.3 4887.3 4964.9 5002.8 5008.7 5030.3 4457.8 4474.8 4475.2 4487.4 4500.1 18776.7 19186.1 19545.0 19551.5 19556.6 1875.8 1944.9 2047.2 2446.3 2514.4 11967.9 12379.8 12419.9 12714.7 12891.2 1751.2 1775.5 1781.9 1810.3 1858.1 53013.2 53355.5 53387.0 54033.5 54753.5 9028.2 9075.3 9234.9 9241.4 9404.6 12215.3 12316.9 12340.9 12347.6 12356.4 6757.2 6850.0 6850.5 6958.1 6971.3 6423.1 6456.5 6506.6 6550.1 6612.5 5732.0 5779.9 5792.3 5840.6 5854.9 1678.9 1701.4 1741.7 1755.3 1767.8 858.4 890.7 958.2 958.3 973.0 15532.5 15759.8 15985.9 16048.7 16289.8 869.5 879.4 906.0 924.1 929.3 6918.2 9351.2 9405.8 9430.6 9578.1 264579.0 269254.0 270960.0 271430.0 367761.0 64554.0 64850.0 65950.0 67174.3 68009.7 906.8 929.5 947.7 949.1 988.6 14228.7 14546.3 14668.7 14703.3 14902.1 30187.8 30832.2 31109.0 31402.2 31502.4 40990.4 43632.3 43946.6 44796.3 44838.6 6840.8 6853.5 7002.8 7067.0 7098.3 7781.4 9845.0 9917.8 9940.9 10255.6 8974.7 9084.3 9316.7 9581.8 9653.1 9102.5 9185.3 9717.3 9817.0 9905.1 8905.0 9152.0 9931.8 10070.5 10077.7 6898.3 7024.8 7068.9 7075.6 7091.4 8634.7 9246.4 9337.8 9460.9 9727.2 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | [#3] mootools.html Cycles:180 Average:4947.77 Median:5984.31 stddev:2619.75 (43.8%) stddev-sans-first:2611.73 05:46:09 INFO - PROCESS | 26841 | Values: 1172.7 1357.2 1363.1 1471.4 1715.9 5939.7 6828.9 6988.1 7005.9 7006.4 6930.0 7087.0 7091.1 7096.6 7097.9 1686.1 1748.8 1751.5 2044.9 2080.0 2055.4 2101.9 2102.7 2103.3 2109.4 2038.9 2058.7 2066.8 2068.9 2072.1 2012.3 2016.8 2017.5 2019.6 2023.5 2027.9 2065.5 2122.5 2123.7 2127.5 7239.7 7289.4 7290.5 7296.7 7305.6 4275.3 4352.0 4373.7 4402.0 4419.3 2619.7 2660.7 2699.2 2758.4 2769.0 816.4 830.3 839.1 859.9 863.1 9874.1 9896.8 9934.6 9972.3 9981.4 3810.5 3983.5 4018.9 4033.4 4047.9 8445.6 8480.2 8484.4 8484.5 8496.5 4350.7 4362.1 4369.0 4376.2 4385.1 3203.3 3638.1 3689.4 3902.0 3902.5 3409.8 3433.7 3459.9 3472.2 3478.6 1105.3 1114.4 1115.8 1122.1 1123.6 1136.0 1140.8 1148.5 1156.0 1167.5 6587.5 6744.6 6772.7 6833.0 6842.6 408.4 411.7 412.1 413.8 414.4 5021.1 5040.8 5240.3 5265.0 5297.7 8357.7 8613.9 8680.2 8692.1 8697.8 8423.2 8567.5 8617.7 8627.6 8643.6 6821.5 6878.2 6901.2 6950.0 6966.8 6491.0 6534.6 6588.8 6615.4 6619.1 7255.0 7493.4 7910.2 7935.2 8005.0 7491.3 7731.5 7744.2 7782.3 7788.8 5188.1 6003.6 6041.4 6095.5 6106.5 6738.2 6811.5 6830.5 6843.6 6843.9 5892.9 5925.3 6004.2 6061.2 6067.1 5865.1 5930.1 5993.8 5999.6 6001.6 6248.0 6403.4 6421.3 6425.8 6443.3 5964.5 5970.0 5982.8 5985.8 5988.2 5937.5 5966.6 5993.9 5999.7 6028.9 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | [#4] prototype.html Cycles:180 Average:4662.67 Median:5265.21 stddev:1372.80 (26.1%) stddev-sans-first:1336.89 05:46:09 INFO - PROCESS | 26841 | Values: 292.6 298.0 300.3 304.9 305.4 5265.8 5370.9 5395.9 5409.5 5447.3 5189.4 5226.9 5264.6 5274.1 5275.6 3892.3 3997.3 3998.9 4121.7 4129.2 4019.0 4030.3 4041.7 4101.5 4130.7 4071.8 4077.0 4084.4 4085.5 4085.7 4082.5 4087.3 4105.6 4119.4 4122.2 3354.7 3500.9 3544.8 3549.7 3602.0 5122.9 5140.9 5157.0 5158.5 5163.9 4752.0 4752.5 4752.8 4755.9 4763.0 5591.1 5592.0 5600.5 5604.9 5605.6 3955.9 3957.6 3961.6 3963.8 3967.7 5738.7 5810.9 5811.7 5901.5 5906.7 4064.9 4093.1 4095.7 4098.7 4102.2 4134.1 4135.4 4136.9 4139.8 4142.7 4715.0 4715.6 4716.2 4720.8 4727.8 5595.7 5609.7 5615.7 5615.8 5617.4 1435.7 1472.8 1473.7 1474.4 1475.0 963.1 989.6 1001.3 1003.6 1023.0 4748.0 4851.2 4926.9 4945.2 4948.3 5824.0 5826.1 5898.8 5918.4 5931.2 4967.7 4969.4 4970.2 4977.4 4978.4 3104.7 3130.7 3146.9 3148.1 3150.0 5559.9 5584.4 5588.8 5612.5 5616.0 5833.4 5992.5 6026.4 6028.5 6038.4 5528.2 5553.3 5553.9 5555.8 5557.7 5856.7 5865.4 5868.4 5868.9 5870.6 5742.6 5745.2 5751.4 5757.9 5758.3 5540.4 5545.4 5546.2 5550.3 5551.7 3788.3 3945.7 4105.8 4108.1 4109.7 5811.3 5812.9 5832.5 5834.1 5836.4 5601.5 5602.4 5608.4 5611.8 5618.1 5583.6 5597.7 5607.9 5608.0 5621.5 5490.1 5491.6 5494.2 5500.9 5502.7 5463.5 5632.4 5651.2 5657.0 5658.1 5493.6 5493.9 5513.3 5513.4 5515.9 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | [#5] yui.html Cycles:180 Average:11707.70 Median:23871.16 stddev:13251.67 (55.5%) stddev-sans-first:13262.55 05:46:09 INFO - PROCESS | 26841 | Values: 590.2 715.0 738.4 739.9 751.4 10555.6 10721.4 10725.8 10845.8 10878.7 9751.0 10966.5 11014.1 11037.8 11038.7 755.1 758.2 768.6 768.9 770.2 756.7 761.5 762.4 762.4 762.5 789.6 799.7 799.8 800.2 800.7 792.1 792.7 792.9 793.6 793.8 590.4 593.8 594.3 594.9 595.5 9976.2 9977.5 9991.9 10013.7 10042.5 9571.7 9907.4 9946.1 10139.9 10203.2 10345.7 10690.4 10717.4 10887.2 10889.6 3184.5 3214.3 3215.3 3248.4 3278.5 36011.3 38884.0 40557.2 40607.6 41825.6 8377.0 8396.0 8412.8 8423.0 8451.8 14597.2 14621.0 14650.6 16071.1 16235.2 6518.1 6583.6 6689.4 6713.9 6747.2 3655.0 3729.0 3757.4 3838.6 3861.4 2561.3 2588.7 2595.1 2602.2 2608.3 454.1 471.0 476.2 479.6 484.9 541.5 555.4 562.0 570.5 576.5 6816.7 7242.2 7296.0 7347.1 7623.1 581.7 583.6 589.5 603.0 608.5 3299.8 3368.9 3476.8 3546.0 3594.1 47041.8 47271.3 48136.0 48142.8 48418.8 43468.6 43515.8 43853.3 44469.0 44728.8 33085.3 33413.0 38588.4 38696.8 39610.6 7720.9 7882.5 7936.6 8014.6 8244.8 30201.7 30208.8 30447.8 30777.5 30955.7 34161.3 37674.2 37748.4 37927.0 39923.4 9539.4 9893.3 10175.9 10302.1 10574.7 8364.5 10626.6 10665.5 10917.7 11301.4 9843.8 10284.6 10310.8 10363.8 10403.5 9989.1 10263.3 10334.7 10356.4 10363.3 10008.9 10465.8 10562.5 10610.4 10617.3 8161.8 8395.2 8430.9 8449.0 8494.5 8562.7 8698.7 8781.6 8914.3 9111.6 05:46:09 INFO - PROCESS | 26841 | -------- Summary: end -------- 05:46:09 INFO - PROCESS | 26841 | 05:46:09 INFO - PROCESS | 26841 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:09 INFO - PROCESS | 26841 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:09 INFO - PROCESS | 26841 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:09 INFO - PROCESS | 26841 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:09 INFO - PROCESS | 26841 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:10 INFO - TEST-INFO | 26841: exit 0 05:46:10 INFO - TEST-OK | dromaeo_css | took 1116185ms 05:46:10 INFO - TEST-START | kraken 05:46:10 INFO - operating with platform_type : linux_ 05:46:10 INFO - Initialising browser for kraken test... 05:46:10 INFO - TEST-INFO | started process 27020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7phbYY/profile http://localhost:41034/getInfo.html) 05:46:14 INFO - PROCESS | 27020 | __metrics Screen width/height:1600/1200 05:46:14 INFO - PROCESS | 27020 | colorDepth:24 05:46:14 INFO - PROCESS | 27020 | Browser inner width/height: 1024/697 05:46:14 INFO - PROCESS | 27020 | __metrics 05:46:15 INFO - PROCESS | 27020 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:15 INFO - PROCESS | 27020 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:15 INFO - PROCESS | 27020 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:15 INFO - PROCESS | 27020 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:15 INFO - PROCESS | 27020 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:15 INFO - PROCESS | 27020 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:15 INFO - PROCESS | 27020 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:15 INFO - PROCESS | 27020 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:46:16 INFO - TEST-INFO | 27020: exit 0 05:46:16 INFO - Browser initialized. 05:46:16 INFO - Running cycle 1/1 for kraken test... 05:46:16 INFO - TEST-INFO | started process 27105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7phbYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:28 INFO - PROCESS | 27105 | RSS: Main: 152735744 05:46:28 INFO - PROCESS | 27105 | 05:46:30 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41034/tests/kraken/driver.html?testName=audio-beat-detection) 05:46:31 INFO - PROCESS | 27105 | RSS: Main: 196370432 05:46:31 INFO - PROCESS | 27105 | 05:46:34 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41034/tests/kraken/driver.html?testName=audio-dft) 05:46:34 INFO - PROCESS | 27105 | RSS: Main: 186142720 05:46:34 INFO - PROCESS | 27105 | 05:46:37 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41034/tests/kraken/driver.html?testName=audio-fft) 05:46:38 INFO - PROCESS | 27105 | RSS: Main: 174235648 05:46:38 INFO - PROCESS | 27105 | 05:46:40 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41034/tests/kraken/driver.html?testName=audio-oscillator) 05:46:41 INFO - PROCESS | 27105 | RSS: Main: 174579712 05:46:41 INFO - PROCESS | 27105 | 05:46:43 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41034/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:46:44 INFO - PROCESS | 27105 | RSS: Main: 173645824 05:46:44 INFO - PROCESS | 27105 | 05:46:47 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41034/tests/kraken/driver.html?testName=imaging-darkroom) 05:46:47 INFO - PROCESS | 27105 | RSS: Main: 175357952 05:46:47 INFO - PROCESS | 27105 | 05:46:51 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41034/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:51 INFO - PROCESS | 27105 | RSS: Main: 174989312 05:46:51 INFO - PROCESS | 27105 | 05:46:54 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41034/tests/kraken/driver.html?testName=json-parse-financial) 05:46:55 INFO - PROCESS | 27105 | RSS: Main: 176680960 05:46:55 INFO - PROCESS | 27105 | 05:46:56 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41034/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:57 INFO - PROCESS | 27105 | RSS: Main: 185683968 05:46:57 INFO - PROCESS | 27105 | 05:46:59 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41034/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:59 INFO - PROCESS | 27105 | RSS: Main: 183926784 05:46:59 INFO - PROCESS | 27105 | 05:47:02 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41034/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:02 INFO - PROCESS | 27105 | RSS: Main: 193118208 05:47:02 INFO - PROCESS | 27105 | 05:47:05 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:05 INFO - PROCESS | 27105 | RSS: Main: 196972544 05:47:05 INFO - PROCESS | 27105 | 05:47:08 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:09 INFO - PROCESS | 27105 | RSS: Main: 197308416 05:47:09 INFO - PROCESS | 27105 | 05:47:10 INFO - PROCESS | 27105 | Cycle 1(1): loaded http://localhost:41034/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41034/tests/kraken/driver.html?testName=ai-astar) 05:47:11 INFO - PROCESS | 27105 | RSS: Main: 257298432 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | __start_tp_report 05:47:11 INFO - PROCESS | 27105 | _x_x_mozilla_page_load 05:47:11 INFO - PROCESS | 27105 | _x_x_mozilla_page_load_details 05:47:11 INFO - PROCESS | 27105 | |i|pagename|runs| 05:47:11 INFO - PROCESS | 27105 | |0;ai-astar;112;114;109;113;113;113;101;112;114;114 05:47:11 INFO - PROCESS | 27105 | |1;audio-beat-detection;157;139;159;169;144;152;159;140;184;135 05:47:11 INFO - PROCESS | 27105 | |2;audio-dft;162;162;162;163;161;162;163;162;162;163 05:47:11 INFO - PROCESS | 27105 | |3;audio-fft;74;75;73;150;73;74;82;75;149;75 05:47:11 INFO - PROCESS | 27105 | |4;audio-oscillator;98;98;149;97;99;98;150;98;97;137 05:47:11 INFO - PROCESS | 27105 | |5;imaging-gaussian-blur;119;116;114;114;116;115;115;115;115;116 05:47:11 INFO - PROCESS | 27105 | |6;imaging-darkroom;146;147;147;147;147;146;146;146;146;147 05:47:11 INFO - PROCESS | 27105 | |7;imaging-desaturate;96;95;95;96;96;96;95;96;96;96 05:47:11 INFO - PROCESS | 27105 | |8;json-parse-financial;66;68;67;67;67;67;67;75;66;64 05:47:11 INFO - PROCESS | 27105 | |9;json-stringify-tinderbox;71;72;71;71;71;71;72;71;72;71 05:47:11 INFO - PROCESS | 27105 | |10;stanford-crypto-aes;83;83;84;86;92;85;86;93;86;86 05:47:11 INFO - PROCESS | 27105 | |11;stanford-crypto-ccm;127;128;121;118;119;123;125;123;131;123 05:47:11 INFO - PROCESS | 27105 | |12;stanford-crypto-pbkdf2;157;138;142;139;154;142;162;150;148;147 05:47:11 INFO - PROCESS | 27105 | |13;stanford-crypto-sha256-iterative;70;73;72;72;70;70;69;73;70;69 05:47:11 INFO - PROCESS | 27105 | __end_tp_report 05:47:11 INFO - PROCESS | 27105 | __start_cc_report 05:47:11 INFO - PROCESS | 27105 | _x_x_mozilla_cycle_collect,1151 05:47:11 INFO - PROCESS | 27105 | __end_cc_report 05:47:11 INFO - PROCESS | 27105 | __startTimestamp1456753631156__endTimestamp 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | ------- Summary: start ------- 05:47:11 INFO - PROCESS | 27105 | Number of tests: 14 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.98 (3.5%) stddev-sans-first:4.22 05:47:11 INFO - PROCESS | 27105 | Values: 112.0 114.0 109.0 113.0 113.0 113.0 101.0 112.0 114.0 114.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:158.00 stddev:15.16 (9.6%) stddev-sans-first:16.04 05:47:11 INFO - PROCESS | 27105 | Values: 157.0 139.0 159.0 169.0 144.0 152.0 159.0 140.0 184.0 135.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:47:11 INFO - PROCESS | 27105 | Values: 162.0 162.0 162.0 163.0 161.0 162.0 163.0 162.0 162.0 163.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#3] audio-fft Cycles:10 Average:90.00 Median:74.50 stddev:31.46 (42.2%) stddev-sans-first:32.84 05:47:11 INFO - PROCESS | 27105 | Values: 74.0 75.0 73.0 150.0 73.0 74.0 82.0 75.0 149.0 75.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#4] audio-oscillator Cycles:10 Average:112.10 Median:98.00 stddev:23.19 (23.7%) stddev-sans-first:24.03 05:47:11 INFO - PROCESS | 27105 | Values: 98.0 98.0 149.0 97.0 99.0 98.0 150.0 98.0 97.0 137.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.50 stddev:1.43 (1.2%) stddev-sans-first:0.78 05:47:11 INFO - PROCESS | 27105 | Values: 119.0 116.0 114.0 114.0 116.0 115.0 115.0 115.0 115.0 116.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:47:11 INFO - PROCESS | 27105 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:47:11 INFO - PROCESS | 27105 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:67.00 stddev:2.88 (4.3%) stddev-sans-first:3.00 05:47:11 INFO - PROCESS | 27105 | Values: 66.0 68.0 67.0 67.0 67.0 67.0 67.0 75.0 66.0 64.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 05:47:11 INFO - PROCESS | 27105 | Values: 71.0 72.0 71.0 71.0 71.0 71.0 72.0 71.0 72.0 71.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:3.44 (4.0%) stddev-sans-first:3.42 05:47:11 INFO - PROCESS | 27105 | Values: 83.0 83.0 84.0 86.0 92.0 85.0 86.0 93.0 86.0 86.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.00 stddev:4.05 (3.3%) stddev-sans-first:4.13 05:47:11 INFO - PROCESS | 27105 | Values: 127.0 128.0 121.0 118.0 119.0 123.0 125.0 123.0 131.0 123.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:149.00 stddev:7.96 (5.3%) stddev-sans-first:7.74 05:47:11 INFO - PROCESS | 27105 | Values: 157.0 138.0 142.0 139.0 154.0 142.0 162.0 150.0 148.0 147.0 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.55 (2.2%) stddev-sans-first:1.62 05:47:11 INFO - PROCESS | 27105 | Values: 70.0 73.0 72.0 72.0 70.0 70.0 69.0 73.0 70.0 69.0 05:47:11 INFO - PROCESS | 27105 | -------- Summary: end -------- 05:47:11 INFO - PROCESS | 27105 | 05:47:11 INFO - PROCESS | 27105 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:47:11 INFO - PROCESS | 27105 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:47:11 INFO - PROCESS | 27105 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:47:11 INFO - PROCESS | 27105 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:47:11 INFO - PROCESS | 27105 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:47:11 INFO - PROCESS | 27105 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:47:11 INFO - PROCESS | 27105 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 05:47:12 INFO - TEST-INFO | 27105: exit 0 05:47:12 INFO - TEST-OK | kraken | took 61779ms 05:47:12 INFO - SUITE-END | took 1177s 05:47:12 INFO - Completed test suite (00:19:38) 05:47:12 INFO - Working with test: dromaeo_css 05:47:12 INFO - Generating results file: dromaeo_css 05:47:12 INFO - Working with test: kraken 05:47:12 INFO - Generating results file: kraken 05:47:12 INFO - javascript benchmark 05:47:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:47:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:47:12 INFO - process_Request line: dromaeo_css 6136.64 graph.html#tests=[[72,132,35]] 05:47:12 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:47:12 INFO - process_Request line: kraken 1554.90 graph.html#tests=[[232,132,35]] 05:47:12 INFO - RETURN: dromaeo_css: 6136.64 05:47:12 INFO - RETURN: kraken: 1554.90 05:47:12 INFO - javascript benchmark 05:47:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2571.987140064299, 2629.184952664673, 2629.329520972152, 2640.4455064436465, 2659.8803053862575, 4427.0, 4480.171168333861, 4513.413256276684, 4517.186906356855, 4526.321051842226, 4533.184026875161, 4549.931751023737, 4560.97719511402, 4588.724676519411, 4668.346431499593, 4070.3487442009286, 4129.938050929239, 4132.5040995080635, 4137.689673274516, 4168.083021735221, 4076.082881351702, 4151.00375909781, 4153.210889930919, 4164.625183733463, 4224.72539284947, 4055.71609987301, 4120.855770048064, 4174.749515029108, 4231.836245032609, 4247.957520424787, 4158.8336466541305, 4178.456800615931, 4184.665226781881, 4216.198922204771, 4223.683223758199, 4006.338954072604, 4131.958680413218, 4153.771542565158, 4155.23128221277, 4192.035831758682, 4376.671749618791, 4403.515613282536, 4435.8225670973125, 4447.444069491314, 4456.665750068758, 4871.050145221683, 4881.585065269456, 4883.316335713003, 4887.511248875119, 4893.804247830082, 4673.252279635242, 4852.902941941176, 4884.072026315024, 4905.043516514281, 4906.484819093979, 4569.246074397754, 4571.839985600488, 4573.039661671053, 4577.038821847383, 4618.422697162889, 4971.030649023406, 5000.648657279469, 5015.14742493777, 5017.096922553976, 5058.317127187856, 4579.335996280521, 4644.883877903012, 4793.688410253322, 4806.759662016885, 4815.061063092733, 4853.6602437829715, 4863.440704318978, 4867.902641947141, 4886.633502487328, 4912.263160525949, 4797.424309082862, 4832.95167048332, 4833.830815921426, 4834.468208497063, 4871.683340582851, 4607.516210797885, 4775.95224047762, 4795.352627395257, 4852.8786780330065, 4876.414830220397, 4060.9187816244103, 4082.530508991504, 4085.3667681509414, 4100.200460910153, 4105.548389677133, 3590.9461358079648, 3591.838367273479, 3601.513795637555, 3607.8196090195383, 3627.220147668211, 4031.8387264509092, 4104.8768536943935, 4196.538380778112, 4251.979524914061, 4256.702030857872, 4872.561469467694, 4882.36529251195, 4904.0191961607825, 4913.70517768935, 4927.088488629615, 4195.056112374752, 4202.558731333227, 4204.159168166379, 4223.957760422357, 4260.020195355024, 4131.5042194936195, 4288.742675439484, 4345.109252603209, 4366.585174408489, 4383.912321753547, 4574.176648203355, 4574.931376029363, 4593.747343896118, 4594.2419500783335, 4635.791389387486, 4631.698939568917, 4852.611791056636, 4856.1987272099705, 4860.270959356125, 4890.095332363524, 4524.954750452585, 4532.252178390529, 4578.88552786183, 4580.725156490621, 4595.609373203181, 4761.40482439695, 4797.328374027708, 4798.136335459651, 4800.35195248637, 4823.517648235148, 4584.724916504887, 4802.399700037496, 4870.926936095891, 4876.634252431153, 4889.071076495455, 4729.266963620645, 4732.077244937204, 4744.572988431058, 4749.0, 4788.784504697367, 4719.622430205644, 4735.289706544046, 4737.810487580458, 4780.689255198401, 4784.641151913551, 4545.454545454567, 4584.793684284282, 4660.231061874752, 4664.090502352009, 4665.440147182359, 4726.196546587157, 4742.810287588458, 4747.454042785124, 4753.595944344631, 4769.2130798417875, 4647.419072615923, 4648.883777905444, 4649.386084583902, 4649.86050418488, 4682.063587282489], "unit": "score", "name": "dojo.html", "value": 4451.077164669512}, {"lowerIsBetter": false, "replicates": [482.594620518764, 493.1714719271623, 494.7031780931444, 503.5392615756583, 525.3039722367862, 24638.26085217444, 35070.64929350706, 35633.2873342533, 35662.99999999997, 35687.643123568756, 40402.0, 40923.59076409235, 40925.0, 41108.0, 41112.0, 6802.489813264, 7729.806754831118, 7914.3272821810215, 7927.762167134995, 7928.04863416388, 6804.965975170117, 6894.448444124458, 9878.901210987906, 10081.596736130547, 10092.646757363495, 9780.168685661727, 9882.258830587698, 9891.357061790997, 9894.703158905244, 9909.157721593674, 9672.709818705414, 9720.125188732978, 9733.805323893554, 9739.318247722662, 9752.122308992224, 9875.358101723437, 10166.08505234525, 10166.237532185116, 10170.186385089175, 10173.389596624153, 34478.482822757425, 35045.474317885, 35079.64920350789, 35092.824535877415, 35106.77126300567, 2707.296103013211, 2720.9591856122174, 2832.362718388367, 3505.91235219119, 3590.0486371111674, 28694.0, 28753.85623071892, 29044.709552904413, 29149.417011659647, 29169.270768230752, 2923.298408381973, 2927.34134819666, 2967.5697023931625, 2985.4177286038434, 3006.744426723731, 225411.0, 227053.0, 227388.0, 227405.0, 228315.0, 56315.15527267094, 56913.71543142258, 57095.42904570984, 57116.0, 57284.427155727906, 60419.0, 60940.39059609347, 61459.70294010341, 61496.0, 61583.6920815393, 11446.0, 11590.304581724955, 11590.304581725124, 11598.536058557564, 11603.361815100081, 8238.09380968093, 9630.807383852283, 9638.228941684789, 9726.36778609388, 9732.2214222862, 19345.613087738166, 19455.0, 19683.31108411199, 19683.606327873364, 19724.802751972584, 7172.49792514519, 7426.702931882664, 7525.661345239478, 7534.64376412251, 7554.0, 846.7586737779703, 860.7805009722481, 881.3389957531851, 907.3376435202339, 1016.8983101689772, 26386.86806565993, 26951.460970780867, 27421.862890685417, 27463.450730985267, 27521.17436476909, 995.5569771451635, 1000.479750529735, 1001.1190152665753, 1041.3023274406014, 1101.713554475842, 13823.377947992365, 14071.788923166161, 14100.717985640229, 14321.427142914166, 14364.928175359057, 256861.0, 260652.0, 260986.0, 261484.0, 261547.0, 45935.77032114818, 46442.0, 46479.76760116178, 46515.30227046597, 46541.30188047182, 1061.5117046158698, 1171.6719318590638, 1180.8760080191628, 1182.361524776611, 1221.7190046289224, 24700.25899223026, 26517.734822651528, 26872.865635671697, 26880.462390751683, 26943.595846061933, 36553.268934621694, 36851.81574092113, 36910.8154459226, 36918.815405922796, 36978.0, 152854.0, 153448.23275883548, 153488.0, 153697.0, 153861.0, 23320.416989575395, 28114.0, 28747.712522874503, 28868.855655721585, 28900.132996010154, 33817.83091084529, 41321.586784132975, 41583.58416415918, 42611.3608295882, 42662.0, 34547.0, 35107.473387899714, 36470.08824779402, 36531.634683652825, 36586.8170659145, 32222.677773221967, 33765.83117084399, 33878.66121338755, 34108.0, 34188.658113419544, 33806.49290260697, 33889.83055084709, 34050.489242660886, 34374.656253438145, 34557.654423455446, 29847.403051939273, 30328.84835575808, 30338.089857304316, 30355.696443035285, 30398.54402184013, 23247.651285231073, 23800.88099559491, 24061.879690601436, 24104.0, 24169.395765106012], "unit": "score", "name": "ext.html", "value": 16792.656058917448}, {"lowerIsBetter": false, "replicates": [337.84121462912435, 337.9966200337996, 342.34441045398063, 342.3597871979398, 344.57272981502945, 14243.92878035611, 15096.924515377435, 15638.765418518717, 16302.673946521092, 16305.347786088541, 14742.705145897102, 14856.777148342757, 15115.546533604009, 15696.13671248081, 15709.371625134982, 4894.975525122379, 5083.771230294646, 5094.719790411545, 5096.541311281984, 5103.0, 4909.0672772173175, 4944.728039957801, 5038.672486288379, 5043.747812609373, 5117.820876269331, 5023.924641130386, 5034.949650503485, 5043.798248070073, 5050.747462626854, 5069.315642388286, 4887.315775791392, 4964.925526117093, 5002.774875130628, 5008.724520151391, 5030.295758593781, 4457.777111144463, 4474.798634061475, 4475.1944649963, 4487.439070116236, 4500.077484115781, 18776.71834922477, 19186.13662385196, 19545.0, 19551.511212219666, 19556.608867822564, 1875.7842848072373, 1944.931927382549, 2047.2425202674956, 2446.2905757330354, 2514.446821699223, 11967.94016029923, 12379.814302785466, 12419.875801241962, 12714.682132946658, 12891.16207446513, 1751.1944505527472, 1775.4673597920573, 1781.9287228510843, 1810.2577943043289, 1858.0709645177412, 53013.204801928005, 53355.466445335434, 53387.0, 54033.459665403236, 54753.45246547523, 9028.187463128219, 9075.273978081737, 9234.86147707785, 9241.399309044891, 9404.576794044284, 12215.26708397499, 12316.876831231752, 12340.938295308466, 12347.62957111288, 12356.443960021821, 6757.155355580552, 6850.0, 6850.45196384298, 6958.095447591781, 6971.3028697129885, 6423.100765892778, 6456.451201647913, 6506.577072490368, 6550.115734375893, 6612.471002319803, 5732.022452253966, 5779.88440231193, 5792.275965504312, 5840.649561026352, 5854.912176317359, 1678.9496315110566, 1701.387500499819, 1741.747446620233, 1755.297361559311, 1767.8320559546823, 858.4420126917429, 890.6615486115235, 958.1999030809213, 958.3339578992673, 972.9659461918799, 15532.534023979299, 15759.818182722403, 15985.920070399807, 16048.679026419406, 16289.755653665205, 869.4870026684287, 879.3624622148891, 905.959231834569, 924.0805398628407, 929.2705226397246, 6918.163552943269, 9351.205147562534, 9405.76485587852, 9430.622775089058, 9578.090081442251, 264579.0, 269254.0, 270960.0, 271430.0, 367761.0, 64554.0, 64850.0, 65950.0, 67174.32825671778, 68009.65995169993, 906.7914379692708, 929.4934260827865, 947.7346343023964, 949.0651708067548, 988.6342053440274, 14228.715425691635, 14546.345414456586, 14668.706625867637, 14703.3383497745, 14902.105873647182, 30187.849060754557, 30832.229194270323, 31109.0, 31402.21494462657, 31502.36995260128, 40990.385144222266, 43632.34551481667, 43946.560534394244, 44796.32805507855, 44838.55161448344, 6840.828979275558, 6853.4859885507785, 7002.824929376602, 7067.0, 7098.3256590623805, 7781.377489800916, 9844.96627854065, 9917.752056198653, 9940.900590994286, 10255.58977640886, 8974.685885993958, 9084.273258139465, 9316.720498385059, 9581.760455988657, 9653.082957119062, 9102.453852768855, 9185.265178785814, 9717.319787614799, 9817.0, 9905.108540231413, 8904.955475222583, 9152.0, 9931.801363972536, 10070.546825392728, 10077.69766906994, 6898.275681053417, 7024.824379390556, 7068.9293107070325, 7075.646217689198, 7091.361777440055, 8634.654613815628, 9246.398984066283, 9337.813243734952, 9460.905390946278, 9727.173190278623], "unit": "score", "name": "jquery.html", "value": 7727.901882861673}, {"lowerIsBetter": false, "replicates": [1172.7185475485885, 1357.151780137414, 1363.100353766514, 1471.39672734179, 1715.9056251906147, 5939.673317967516, 6828.897566536506, 6988.056612357343, 7005.894911576331, 7006.439484841219, 6929.965350173255, 7086.964565177167, 7091.11361079865, 7096.609686467243, 7097.85804283914, 1686.1147897353865, 1748.7814023247095, 1751.5008222656545, 2044.94887627809, 2079.9584008319825, 2055.4142069510194, 2101.873887566743, 2102.6951092091635, 2103.2743703422293, 2109.4093653776968, 2038.8572799904014, 2058.7220725202133, 2066.8346532277383, 2068.88621125838, 2072.129705523676, 2012.3359291433865, 2016.8084032016934, 2017.4552870724895, 2019.5758890632985, 2023.4840115770385, 2027.9391618251475, 2065.473304307407, 2122.490602255463, 2123.7239158909397, 2127.5425783456476, 7239.746608868717, 7289.416846652255, 7290.489665723401, 7296.708131674726, 7305.598192099433, 4275.315949448073, 4351.999040220735, 4373.671974601918, 4401.977990110029, 4419.292913133883, 2619.698734645521, 2660.720624334456, 2699.2307192450057, 2758.4207316463367, 2769.0446795855396, 816.4488969945263, 830.2735106781566, 839.106351735406, 859.862422012475, 863.0765081362944, 9874.111329980336, 9896.802063958752, 9934.602615895355, 9972.301938864282, 9981.401115933068, 3810.5236845394325, 3983.541892682321, 4018.9196216075516, 4033.394990751352, 4047.9392809107885, 8445.57772111392, 8480.236778689947, 8484.363672724447, 8484.53335066565, 8496.53269070207, 4350.73895566267, 4362.083962367875, 4368.956310436918, 4376.234159022222, 4385.079133381962, 3203.2952750394875, 3638.0904773806546, 3689.3912504437003, 3902.043999220209, 3902.453656488094, 3409.829508524564, 3433.7424693148114, 3459.9308013840086, 3472.2013936794174, 3478.6347433519622, 1105.2760441910561, 1114.3815182573587, 1115.7880002799443, 1122.1079242002627, 1123.5898896902736, 1135.9659210223706, 1140.7946569617382, 1148.4544841200363, 1155.9537618495335, 1167.4688016952266, 6587.473002159816, 6744.629045402452, 6772.69522871472, 6833.043373927654, 6842.5552339098795, 408.43023981545576, 411.7200303793449, 412.13451751322583, 413.7682897577366, 414.3929143804341, 5021.121303771898, 5040.84877453677, 5240.292560504359, 5265.0, 5297.735113244399, 8357.707480238285, 8613.870791938127, 8680.175383338572, 8692.087330830173, 8697.826043479221, 8423.241908228289, 8567.485950842969, 8617.69838055665, 8627.568621568897, 8643.567821608895, 6821.488388370892, 6878.243393226741, 6901.240863505011, 6949.965250173716, 6966.756163534354, 6491.0, 6534.607923524603, 6588.8352791180605, 6615.404613584608, 6619.139511863427, 7255.0, 7493.363064139609, 7910.248526389983, 7935.246151615587, 8004.959975200087, 7491.250874912465, 7731.458797884319, 7744.225577442436, 7782.338501227459, 7788.7663370096725, 5188.092083885381, 6003.609765365237, 6041.365656605993, 6095.51235901118, 6106.45041946227, 6738.191417029988, 6811.4550835934, 6830.521863469509, 6843.555168914005, 6843.863122737418, 5892.882142357214, 5925.259342582177, 6004.189434426296, 6061.15143879866, 6067.059605761114, 5865.149553314831, 5930.140129681258, 5993.760249589967, 5999.610025348338, 6001.609895356963, 6247.96876015617, 6403.359664033559, 6421.293657697743, 6425.807225783234, 6443.291237963726, 5964.463198312173, 5969.970150149222, 5982.820515384546, 5985.790497332572, 5988.161657368059, 5937.465628093492, 5966.552508561962, 5993.850153746192, 5999.70001499932, 6028.939710602838], "unit": "score", "name": "mootools.html", "value": 3973.433855954587}, {"lowerIsBetter": false, "replicates": [292.58160830013077, 298.0, 300.3003003003003, 304.9252933031408, 305.43646971337876, 5265.815696450625, 5370.892582148354, 5395.946040539593, 5409.486098820616, 5447.291852059237, 5189.377274727029, 5226.947730522703, 5264.6051546134, 5274.05067087924, 5275.551578115865, 3892.3188442022674, 3997.2804895118866, 3998.900027499307, 4121.711480196387, 4129.236091323108, 4019.0153412414, 4030.314846476106, 4041.737287076345, 4101.52832424272, 4130.690198235129, 4071.7760523171214, 4076.979615101935, 4084.4077608746716, 4085.4893138357706, 4085.6527195188446, 4082.5100987881347, 4087.305158123111, 4105.568915263884, 4119.423280740699, 4122.216778812016, 3354.681305275995, 3500.94748578769, 3544.7873127612424, 3549.698275646573, 3602.0274525877867, 5122.948770512285, 5140.871478213037, 5156.994386094713, 5158.53573178412, 5163.870903227449, 4752.049590081998, 4752.477227504972, 4752.7861246244, 4755.881102972418, 4763.0, 5591.10542313228, 5592.049351610236, 5600.467955544217, 5604.859878503029, 5605.5515558755205, 3955.940660890089, 3957.584453632356, 3961.564227934925, 3963.801809909493, 3967.7222594418404, 5738.741756620921, 5810.854728631776, 5811.738471768781, 5901.527877769769, 5906.700525884298, 4064.898377540585, 4093.0585965228165, 4095.692823038284, 4098.73358231714, 4102.200070986189, 4134.131832315247, 4135.359019352005, 4136.937945930814, 4139.79301034947, 4142.689298302639, 4714.976425117852, 4715.57559819611, 4716.151092803259, 4720.787564559603, 4727.787249573777, 5595.748191331319, 5609.719514024282, 5615.719214039282, 5615.792604590033, 5617.38208797032, 1435.7415665180158, 1472.8453512381259, 1473.668424604477, 1474.3586539855198, 1474.9852501475063, 963.1043129889131, 989.5843745626854, 1001.2540657210279, 1003.5835128421769, 1023.0179028133076, 4747.976260118747, 4851.223804191312, 4926.876828079255, 4945.159322915113, 4948.257761335828, 5824.0, 5826.126081087871, 5898.793542226087, 5918.437748413894, 5931.1992880960515, 4967.677100988424, 4969.35398398206, 4970.2296144097, 4977.427595826454, 4978.4025916890205, 3104.6584875663657, 3130.686931306851, 3146.8741250350186, 3148.1499995001677, 3150.0, 5559.8880223955375, 5584.385717571064, 5588.776448942078, 5612.5229355504425, 5616.0, 5833.358330583633, 5992.490638295793, 6026.397360264026, 6028.517718582503, 6038.365971573009, 5528.226048353234, 5553.278073850535, 5553.916691249554, 5555.805546805843, 5557.666540007532, 5856.736446859987, 5865.384134665798, 5868.4424979626865, 5868.94131058684, 5870.618409803349, 5742.626729262584, 5745.166950792028, 5751.396103409082, 5757.9424205757405, 5758.3090029196765, 5540.418256083053, 5545.417731138173, 5546.223528705904, 5550.306211723535, 5551.722413879371, 3788.2991646544374, 3945.7040721945395, 4105.794710264415, 4108.055147316074, 4109.732867363612, 5811.302643682785, 5812.883742325045, 5832.50423713989, 5834.124881267844, 5836.358000619844, 5601.5238704710555, 5602.3837377887585, 5608.38307786135, 5611.831645050655, 5618.129189975561, 5583.637063590853, 5597.720113994365, 5607.943920560742, 5607.990561698934, 5621.5221706155435, 5490.121580547253, 5491.588130890279, 5494.203340515683, 5500.862478438071, 5502.669839809464, 5463.508284254436, 5632.408597097246, 5651.15232715096, 5657.0, 5658.066419040977, 5493.615446918678, 5493.945060549503, 5513.3108361454815, 5513.393526712139, 5515.917261241165], "unit": "score", "name": "prototype.html", "value": 4221.700162645485}, {"lowerIsBetter": false, "replicates": [590.2347501953349, 715.0482905876802, 738.3945164964728, 739.8705226585346, 751.3688501658605, 10555.577776888926, 10721.35671859689, 10725.78548429032, 10845.783084338309, 10878.728031799208, 9751.0, 10966.451677416137, 11014.118870490362, 11037.83443248352, 11038.668839934795, 755.0750330844726, 758.2190343945717, 768.5503980171607, 768.8885111658806, 770.2451597434517, 756.6670664907423, 761.5164370624638, 762.3520007993217, 762.4396068889362, 762.5158024654329, 789.5657388436366, 799.7161007842219, 799.7880561651167, 800.1638287989066, 800.6637212370789, 792.0614072324286, 792.6789650191681, 792.9484583502054, 793.5516433215244, 793.849168657956, 590.4272855330323, 593.8218534439694, 594.349187639534, 594.8869714754182, 595.5325069820213, 9976.152027077707, 9977.451240181786, 9991.850122248172, 10013.699589012342, 10042.497875106288, 9571.664991725256, 9907.405555666683, 9946.055124763136, 10139.898601013969, 10203.183745300432, 10345.741356466073, 10690.358578485315, 10717.426059152725, 10887.183461240438, 10889.564417423293, 3184.538241954927, 3214.292855571794, 3215.26049008727, 3248.3990461764647, 3278.541004259406, 36011.279774404626, 38884.0, 40557.18885622271, 40607.59392406097, 41825.58174418248, 8377.0, 8396.0, 8412.789680258042, 8422.957885210535, 8451.788705282293, 14597.19715415641, 14621.049631774113, 14650.560483185522, 16071.11608861524, 16235.188240587924, 6518.054882042172, 6583.637899915455, 6689.397954184147, 6713.932860671429, 6747.190337159573, 3655.0, 3729.0490924814, 3757.4176002719623, 3838.596947320547, 3861.4014827701753, 2561.3468565515673, 2588.6634737484005, 2595.1046888823703, 2602.193320070784, 2608.3348746069632, 454.137139435076, 471.0273285665091, 476.18096873378425, 479.5516192360154, 484.85939077667786, 541.5180489364469, 555.4029418375263, 561.9634723742944, 570.4979617936273, 576.5042063825107, 6816.693248803816, 7242.203357630657, 7296.0, 7347.105829269598, 7623.123340815766, 581.7120525339984, 583.6177303865975, 589.5224867857049, 602.9939700602938, 608.5466327585976, 3299.818509981974, 3368.9326213475592, 3476.8261586920553, 3545.964540354615, 3594.0835087052633, 47041.764791175825, 47271.29093063607, 48136.0, 48142.75928620334, 48418.75790621095, 43468.565314347084, 43515.78242108769, 43853.34219986703, 44469.0, 44728.77635611801, 33085.338293234, 33413.0, 38588.421173682415, 38696.80651596724, 39610.60389396127, 7720.922790772245, 7882.487638303722, 7936.56348900816, 8014.599270036591, 8244.752657420288, 30201.697983020767, 30208.84895575596, 30447.847760761055, 30777.538336925412, 30955.69044309528, 34161.31677366389, 37674.246515070095, 37748.43377349287, 37927.0, 39923.40114898337, 9539.427634341962, 9893.258005649748, 10175.949120254352, 10302.124319432933, 10574.682759517227, 8364.53995030255, 10626.574937002433, 10665.520051597541, 10917.727056823325, 11301.434928253719, 9843.836174557646, 10284.588616455258, 10310.845337320095, 10363.84454233172, 10403.479826008821, 9989.100980911753, 10263.332883362558, 10334.741631459274, 10356.378617282988, 10363.274570779973, 10008.899911000797, 10465.843012354668, 10562.524686388977, 10610.363378197333, 10617.309874858109, 8161.79595510117, 8395.202455766692, 8430.873536896828, 8449.0, 8494.490330580185, 8562.657493700182, 8698.717885056618, 8781.604827782892, 8914.286857051291, 9111.589978450853], "unit": "score", "name": "yui.html", "value": 5511.126009202864}], "name": "dromaeo_css", "value": 6136.6445179071825}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 109.0, 113.0, 113.0, 113.0, 101.0, 112.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [157.0, 139.0, 159.0, 169.0, 144.0, 152.0, 159.0, 140.0, 184.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 153.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 162.0, 163.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 73.0, 150.0, 73.0, 74.0, 82.0, 75.0, 149.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.0}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 149.0, 97.0, 99.0, 98.0, 150.0, 98.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 112.1}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 114.0, 114.0, 116.0, 115.0, 115.0, 115.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 75.0, 66.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 67.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 71.0, 71.0, 71.0, 72.0, 71.0, 72.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 86.0, 92.0, 85.0, 86.0, 93.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [127.0, 128.0, 121.0, 118.0, 119.0, 123.0, 125.0, 123.0, 131.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [157.0, 138.0, 142.0, 139.0, 154.0, 142.0, 162.0, 150.0, 148.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 72.0, 72.0, 70.0, 70.0, 69.0, 73.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1554.9}]} 05:47:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1554.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6136.64"}}} 05:47:12 INFO - Return code: 0 05:47:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:47:12 INFO - # TBPL SUCCESS # 05:47:12 INFO - Running post-action listener: _resource_record_post_action 05:47:12 INFO - Running post-run listener: _resource_record_post_run 05:47:13 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 525127680; Read time: 0; Write time: 494384 05:47:13 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233496576; Read time: 0; Write time: 263448 05:47:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 291631104; Read time: 0; Write time: 230936 05:47:13 INFO - Running post-run listener: _upload_blobber_files 05:47:13 INFO - Blob upload gear active. 05:47:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:47:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:47:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:14 INFO - (blobuploader) - INFO - Done attempting. 05:47:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:47:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:47:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:15 INFO - (blobuploader) - INFO - Done attempting. 05:47:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:15 INFO - Return code: 0 05:47:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3752c0be236c4d5b5dc01593168429e5f8b8b3f922fec48a4a33f0eb8e8312b045d4f4053fbb37b9b679606af9857a99b8e4705153d699fc9de87c7df7bdd00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb7141136d07da56350a68bdc8df8bceaf98b4880d7b51d9de2155d37aa0f14a59071eb68d492467d1cda3d0d06a200f689b4bd33d86a316ab64f240d0a3518b"} 05:47:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:15 INFO - Contents: 05:47:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3752c0be236c4d5b5dc01593168429e5f8b8b3f922fec48a4a33f0eb8e8312b045d4f4053fbb37b9b679606af9857a99b8e4705153d699fc9de87c7df7bdd00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb7141136d07da56350a68bdc8df8bceaf98b4880d7b51d9de2155d37aa0f14a59071eb68d492467d1cda3d0d06a200f689b4bd33d86a316ab64f240d0a3518b"} 05:47:15 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:15 INFO - Copying logs to upload dir... 05:47:15 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.786543 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-29 05:47:14.715486) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 05:47:14.718634) ========= 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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 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/d3752c0be236c4d5b5dc01593168429e5f8b8b3f922fec48a4a33f0eb8e8312b045d4f4053fbb37b9b679606af9857a99b8e4705153d699fc9de87c7df7bdd00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb7141136d07da56350a68bdc8df8bceaf98b4880d7b51d9de2155d37aa0f14a59071eb68d492467d1cda3d0d06a200f689b4bd33d86a316ab64f240d0a3518b"} build_url:https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/XklxiOyIQAqkgfa2STm8XQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3752c0be236c4d5b5dc01593168429e5f8b8b3f922fec48a4a33f0eb8e8312b045d4f4053fbb37b9b679606af9857a99b8e4705153d699fc9de87c7df7bdd00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb7141136d07da56350a68bdc8df8bceaf98b4880d7b51d9de2155d37aa0f14a59071eb68d492467d1cda3d0d06a200f689b4bd33d86a316ab64f240d0a3518b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 05:47:14.750313) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:47:14.750667) ========= 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=33d5923976266a1c518c4bf7000001ab-1456748327.761112-866584259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 05:47:14.831171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 05:47:14.834553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 05:47:14.834869) ========= ========= Total master_lag: 0.32 =========