builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-037 starttime: 1456765627.35 results: success (0) buildid: 20160229082815 builduid: 205851dec0ae467ba306d1154893480d revision: 6af962bff65de440a88387256ce311c5e5e2e440 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.355125) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.355567) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.355906) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006447 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.386027) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.386345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.413144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.413542) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.463605) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.463907) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.464356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.464690) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 09:07:07-- 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% 88.9M=0s 2016-02-29 09:07:08 (88.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.604734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.605385) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021070 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.656196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:07.656636) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6af962bff65de440a88387256ce311c5e5e2e440 --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 6af962bff65de440a88387256ce311c5e5e2e440 --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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 09:07:08,175 truncating revision to first 12 chars 2016-02-29 09:07:08,175 Setting DEBUG logging. 2016-02-29 09:07:08,175 attempt 1/10 2016-02-29 09:07:08,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6af962bff65d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 09:07:08,460 unpacking tar archive at: fx-team-6af962bff65d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:08.262154) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:08.262558) ========= echo 6af962bff65de440a88387256ce311c5e5e2e440 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6af962bff65de440a88387256ce311c5e5e2e440'] 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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6af962bff65de440a88387256ce311c5e5e2e440 program finished with exit code 0 elapsedTime=0.004536 script_repo_revision: '6af962bff65de440a88387256ce311c5e5e2e440' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:08.316065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:08.316421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 09:07:08.327322) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-02-29 09:07:08.327782) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:08 INFO - MultiFileLogger online at 20160229 09:07:08 in /builds/slave/test 09:07:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 09:07:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:07:08 INFO - {'append_to_log': False, 09:07:08 INFO - 'base_work_dir': '/builds/slave/test', 09:07:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:07:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:07:08 INFO - 'branch': 'Fx-Team-Non-PGO', 09:07:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:08 INFO - 'config_files': ('talos/linux_config.py',), 09:07:08 INFO - 'default_actions': ('clobber', 09:07:08 INFO - 'read-buildbot-config', 09:07:08 INFO - 'download-and-extract', 09:07:08 INFO - 'populate-webroot', 09:07:08 INFO - 'create-virtualenv', 09:07:08 INFO - 'install', 09:07:08 INFO - 'run-tests'), 09:07:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:08 INFO - 'download_minidump_stackwalk': True, 09:07:08 INFO - 'download_symbols': 'ondemand', 09:07:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:08 INFO - 'installer_path': 'installer.exe', 09:07:08 INFO - 'log_level': 'info', 09:07:08 INFO - 'log_name': 'talos', 09:07:08 INFO - 'log_to_console': True, 09:07:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:08 INFO - 'opt_config_files': (), 09:07:08 INFO - 'pip_index': False, 09:07:08 INFO - 'sps_profile': False, 09:07:08 INFO - 'sps_profile_interval': 0, 09:07:08 INFO - 'suite': 'dromaeojs-e10s', 09:07:08 INFO - 'system_bits': '32', 09:07:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:08 INFO - 'title': 'talos-linux64-ix-037', 09:07:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:08 INFO - 'use_talos_json': True, 09:07:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:07:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:08 INFO - 'work_dir': 'build'} 09:07:08 INFO - ##### 09:07:08 INFO - ##### Running clobber step. 09:07:08 INFO - ##### 09:07:08 INFO - Running pre-action listener: _resource_record_pre_action 09:07:08 INFO - Running main action method: clobber 09:07:08 INFO - rmtree: /builds/slave/test/build 09:07:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:07:09 INFO - Running post-action listener: _resource_record_post_action 09:07:09 INFO - ##### 09:07:09 INFO - ##### Running read-buildbot-config step. 09:07:09 INFO - ##### 09:07:09 INFO - Running pre-action listener: _resource_record_pre_action 09:07:09 INFO - Running main action method: read_buildbot_config 09:07:09 INFO - Using buildbot properties: 09:07:09 INFO - { 09:07:09 INFO - "project": "", 09:07:09 INFO - "product": "firefox", 09:07:09 INFO - "script_repo_revision": "production", 09:07:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:07:09 INFO - "repository": "", 09:07:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:07:09 INFO - "buildid": "20160229082815", 09:07:09 INFO - "pgo_build": "False", 09:07:09 INFO - "basedir": "/builds/slave/test", 09:07:09 INFO - "buildnumber": 988, 09:07:09 INFO - "slavename": "talos-linux64-ix-037", 09:07:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:07:09 INFO - "platform": "ubuntu64_hw", 09:07:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:07:09 INFO - "branch": "fx-team", 09:07:09 INFO - "repo_path": "integration/fx-team", 09:07:09 INFO - "revision": "6af962bff65de440a88387256ce311c5e5e2e440", 09:07:09 INFO - "stage_platform": "linux64", 09:07:09 INFO - "builduid": "205851dec0ae467ba306d1154893480d", 09:07:09 INFO - "slavebuilddir": "test" 09:07:09 INFO - } 09:07:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:07:09 INFO - Running post-action listener: _resource_record_post_action 09:07:09 INFO - ##### 09:07:09 INFO - ##### Running download-and-extract step. 09:07:09 INFO - ##### 09:07:09 INFO - Running pre-action listener: _resource_record_pre_action 09:07:09 INFO - Running main action method: download_and_extract 09:07:09 INFO - mkdir: /builds/slave/test/build/tests 09:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:09 INFO - https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:07:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/test_packages.json 09:07:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/test_packages.json 09:07:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:07:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:07:12 INFO - Downloaded 1448 bytes. 09:07:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:07:12 INFO - Using the following test package requirements: 09:07:12 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:12 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:07:12 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:07:12 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:12 INFO - u'jsshell-linux-x86_64.zip'], 09:07:12 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:07:12 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:12 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:07:12 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:07:12 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:07:12 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:12 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:07:12 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:12 INFO - https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/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 09:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/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 09:07:14 INFO - Downloaded 22057460 bytes. 09:07:14 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'] 09:07:14 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 09:07:15 INFO - Return code: 0 09:07:15 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 09:07:15 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')]} 09:07:15 INFO - https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/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 09:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/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 09:07:27 INFO - Downloaded 22057460 bytes. 09:07:27 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'] 09:07:27 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 09:07:28 INFO - Return code: 0 09:07:28 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')]} 09:07:28 INFO - https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/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 09:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/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 09:07:30 INFO - Downloaded 10713410 bytes. 09:07:30 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'] 09:07:30 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 09:07:30 INFO - Return code: 0 09:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:30 INFO - https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/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 09:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/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 09:07:32 INFO - Downloaded 54850715 bytes. 09:07:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:07:32 INFO - mkdir: /builds/slave/test/properties 09:07:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:32 INFO - Contents: 09:07:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:07:32 INFO - Running post-action listener: _resource_record_post_action 09:07:32 INFO - Running post-action listener: set_extra_try_arguments 09:07:32 INFO - ##### 09:07:32 INFO - ##### Running populate-webroot step. 09:07:32 INFO - ##### 09:07:32 INFO - Running pre-action listener: _resource_record_pre_action 09:07:32 INFO - Running main action method: populate_webroot 09:07:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:32 INFO - '--tppagecycles', 09:07:32 INFO - '7'], 09:07:32 INFO - 'tests': ['tsvgm']}}, 09:07:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:07:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:07:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'tests': ['damp', 'tps']}, 09:07:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['damp', 'tps']}, 09:07:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:07:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:32 INFO - 'other': {'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore']}, 09:07:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore']}, 09:07:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore']}, 09:07:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore']}, 09:07:32 INFO - 'other_l64': {'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore']}, 09:07:32 INFO - 'other_nol64': {'tests': ['a11yr', 09:07:32 INFO - 'ts_paint', 09:07:32 INFO - 'tpaint', 09:07:32 INFO - 'sessionrestore', 09:07:32 INFO - 'sessionrestore_no_auto_restore']}, 09:07:32 INFO - 'svgr': {'tests': ['tsvgx', 09:07:32 INFO - 'tsvgr_opacity', 09:07:32 INFO - 'tart', 09:07:32 INFO - 'tscrollx', 09:07:32 INFO - 'cart']}, 09:07:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['tsvgx', 09:07:32 INFO - 'tsvgr_opacity', 09:07:32 INFO - 'tart', 09:07:32 INFO - 'tscrollx', 09:07:32 INFO - 'cart']}, 09:07:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'tests': ['tp5o']}, 09:07:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--e10s'], 09:07:32 INFO - 'tests': ['tp5o']}, 09:07:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--xperf_path', 09:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:32 INFO - 'tests': ['tp5n']}, 09:07:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:32 INFO - 'talos_options': ['--e10s', 09:07:32 INFO - '--xperf_path', 09:07:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:32 INFO - 'tests': ['tp5n']}}, 09:07:32 INFO - 'talos.zip': {'path': '', 09:07:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:32 INFO - Running post-action listener: _resource_record_post_action 09:07:32 INFO - ##### 09:07:32 INFO - ##### Running create-virtualenv step. 09:07:32 INFO - ##### 09:07:32 INFO - Running pre-action listener: _resource_record_pre_action 09:07:32 INFO - Running main action method: create_virtualenv 09:07:32 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:32 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 09:07:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:32 INFO - Using real prefix '/usr' 09:07:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:35 INFO - Installing pip.................done. 09:07:35 INFO - Return code: 0 09:07:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:35 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:35 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 09:07:35 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 09:07:35 INFO - Using env: {'DISPLAY': ':0', 09:07:35 INFO - 'HOME': '/home/cltbld', 09:07:35 INFO - 'LANG': 'en_US.UTF-8', 09:07:35 INFO - 'LANGUAGE': 'en_US:en', 09:07:35 INFO - 'LOGNAME': 'cltbld', 09:07:35 INFO - 'MAIL': '/var/mail/cltbld', 09:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:35 INFO - 'MOZ_NO_REMOTE': '1', 09:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:35 INFO - 'NO_EM_RESTART': '1', 09:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:35 INFO - 'PWD': '/builds/slave/test', 09:07:35 INFO - 'SHELL': '/bin/bash', 09:07:35 INFO - 'SHLVL': '1', 09:07:35 INFO - 'TERM': 'linux', 09:07:35 INFO - 'TMOUT': '86400', 09:07:35 INFO - 'USER': 'cltbld', 09:07:35 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:35 INFO - '_': '/tools/buildbot/bin/python'} 09:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:35 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 09:07:35 INFO - Cleaning up... 09:07:35 INFO - Return code: 0 09:07:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:35 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:35 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 09:07:35 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 09:07:35 INFO - Using env: {'DISPLAY': ':0', 09:07:35 INFO - 'HOME': '/home/cltbld', 09:07:35 INFO - 'LANG': 'en_US.UTF-8', 09:07:35 INFO - 'LANGUAGE': 'en_US:en', 09:07:35 INFO - 'LOGNAME': 'cltbld', 09:07:35 INFO - 'MAIL': '/var/mail/cltbld', 09:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:35 INFO - 'MOZ_NO_REMOTE': '1', 09:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:35 INFO - 'NO_EM_RESTART': '1', 09:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:35 INFO - 'PWD': '/builds/slave/test', 09:07:35 INFO - 'SHELL': '/bin/bash', 09:07:35 INFO - 'SHLVL': '1', 09:07:35 INFO - 'TERM': 'linux', 09:07:35 INFO - 'TMOUT': '86400', 09:07:35 INFO - 'USER': 'cltbld', 09:07:35 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:35 INFO - '_': '/tools/buildbot/bin/python'} 09:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:35 INFO - Downloading/unpacking psutil>=0.7.1 09:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:37 INFO - Installing collected packages: psutil 09:07:37 INFO - Running setup.py install for psutil 09:07:37 INFO - building 'psutil._psutil_linux' extension 09:07:37 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 09:07:37 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 09:07:37 INFO - building 'psutil._psutil_posix' extension 09:07:37 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 09:07:38 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 09:07:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:38 INFO - Successfully installed psutil 09:07:38 INFO - Cleaning up... 09:07:38 INFO - Return code: 0 09:07:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:07:38 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')]} 09:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:38 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')]} 09:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:38 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:38 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 09:07:38 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 09:07:38 INFO - Using env: {'DISPLAY': ':0', 09:07:38 INFO - 'HOME': '/home/cltbld', 09:07:38 INFO - 'LANG': 'en_US.UTF-8', 09:07:38 INFO - 'LANGUAGE': 'en_US:en', 09:07:38 INFO - 'LOGNAME': 'cltbld', 09:07:38 INFO - 'MAIL': '/var/mail/cltbld', 09:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:38 INFO - 'MOZ_NO_REMOTE': '1', 09:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:38 INFO - 'NO_EM_RESTART': '1', 09:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:38 INFO - 'PWD': '/builds/slave/test', 09:07:38 INFO - 'SHELL': '/bin/bash', 09:07:38 INFO - 'SHLVL': '1', 09:07:38 INFO - 'TERM': 'linux', 09:07:38 INFO - 'TMOUT': '86400', 09:07:38 INFO - 'USER': 'cltbld', 09:07:38 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:38 INFO - '_': '/tools/buildbot/bin/python'} 09:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:07:38 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 09:07:38 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 09:07:38 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 09:07:38 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 09:07:38 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 09:07:38 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 09:07:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:07:40 INFO - Installing collected packages: mozsystemmonitor 09:07:40 INFO - Running setup.py install for mozsystemmonitor 09:07:40 INFO - Successfully installed mozsystemmonitor 09:07:40 INFO - Cleaning up... 09:07:40 INFO - Return code: 0 09:07:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:40 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:40 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 09:07:40 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 09:07:40 INFO - Using env: {'DISPLAY': ':0', 09:07:40 INFO - 'HOME': '/home/cltbld', 09:07:40 INFO - 'LANG': 'en_US.UTF-8', 09:07:40 INFO - 'LANGUAGE': 'en_US:en', 09:07:40 INFO - 'LOGNAME': 'cltbld', 09:07:40 INFO - 'MAIL': '/var/mail/cltbld', 09:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:40 INFO - 'MOZ_NO_REMOTE': '1', 09:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:40 INFO - 'NO_EM_RESTART': '1', 09:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:40 INFO - 'PWD': '/builds/slave/test', 09:07:40 INFO - 'SHELL': '/bin/bash', 09:07:40 INFO - 'SHLVL': '1', 09:07:40 INFO - 'TERM': 'linux', 09:07:40 INFO - 'TMOUT': '86400', 09:07:40 INFO - 'USER': 'cltbld', 09:07:40 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:40 INFO - '_': '/tools/buildbot/bin/python'} 09:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:40 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 09:07:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:42 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 09:07:42 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 09:07:42 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 09:07:42 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 09:07:42 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 09:07:42 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 09:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:43 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 09:07:43 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 09:07:43 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 09:07:43 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 09:07:43 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 09:07:43 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 09:07:43 INFO - Downloading docopt-0.6.1.tar.gz 09:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:43 INFO - Running setup.py install for blobuploader 09:07:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:43 INFO - Running setup.py install for requests 09:07:43 INFO - Running setup.py install for docopt 09:07:43 INFO - Successfully installed blobuploader requests docopt 09:07:43 INFO - Cleaning up... 09:07:43 INFO - Return code: 0 09:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:43 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:43 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 09:07:43 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 09:07:43 INFO - Using env: {'DISPLAY': ':0', 09:07:43 INFO - 'HOME': '/home/cltbld', 09:07:43 INFO - 'LANG': 'en_US.UTF-8', 09:07:43 INFO - 'LANGUAGE': 'en_US:en', 09:07:43 INFO - 'LOGNAME': 'cltbld', 09:07:43 INFO - 'MAIL': '/var/mail/cltbld', 09:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:43 INFO - 'MOZ_NO_REMOTE': '1', 09:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:43 INFO - 'NO_EM_RESTART': '1', 09:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:43 INFO - 'PWD': '/builds/slave/test', 09:07:43 INFO - 'SHELL': '/bin/bash', 09:07:43 INFO - 'SHLVL': '1', 09:07:43 INFO - 'TERM': 'linux', 09:07:43 INFO - 'TMOUT': '86400', 09:07:43 INFO - 'USER': 'cltbld', 09:07:43 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:43 INFO - '_': '/tools/buildbot/bin/python'} 09:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:44 INFO - Running setup.py (path:/tmp/pip-zHywCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:44 INFO - Running setup.py (path:/tmp/pip-S1zwGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:44 INFO - Running setup.py (path:/tmp/pip-m9akRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:44 INFO - Running setup.py (path:/tmp/pip-KmoEsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:44 INFO - Running setup.py (path:/tmp/pip-PFNJq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:44 INFO - Running setup.py (path:/tmp/pip-pyXqqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:44 INFO - Running setup.py (path:/tmp/pip-988R5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:44 INFO - Running setup.py (path:/tmp/pip-3cLz2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:44 INFO - Running setup.py (path:/tmp/pip-qYo76o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:44 INFO - Running setup.py (path:/tmp/pip-FTNmRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:44 INFO - Running setup.py (path:/tmp/pip-SRViq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:44 INFO - Running setup.py (path:/tmp/pip-wtbYOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:44 INFO - Running setup.py (path:/tmp/pip-3taY2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:45 INFO - Running setup.py (path:/tmp/pip-bLXOmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:45 INFO - Running setup.py (path:/tmp/pip-mlk7n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:45 INFO - Running setup.py (path:/tmp/pip-yn5eFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:45 INFO - Running setup.py (path:/tmp/pip-h4mDM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:45 INFO - Running setup.py install for manifestparser 09:07:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Running setup.py install for mozcrash 09:07:45 INFO - Running setup.py install for mozdebug 09:07:45 INFO - Running setup.py install for mozdevice 09:07:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Running setup.py install for mozfile 09:07:45 INFO - Running setup.py install for mozhttpd 09:07:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:45 INFO - Running setup.py install for mozinfo 09:07:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Running setup.py install for mozInstall 09:07:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Running setup.py install for mozleak 09:07:46 INFO - Running setup.py install for mozlog 09:07:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Running setup.py install for moznetwork 09:07:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Running setup.py install for mozprocess 09:07:46 INFO - Running setup.py install for mozprofile 09:07:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Running setup.py install for mozrunner 09:07:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:46 INFO - Running setup.py install for mozscreenshot 09:07:46 INFO - Running setup.py install for moztest 09:07:47 INFO - Running setup.py install for mozversion 09:07:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:47 INFO - Cleaning up... 09:07:47 INFO - Return code: 0 09:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:47 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:47 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 09:07:47 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 09:07:47 INFO - Using env: {'DISPLAY': ':0', 09:07:47 INFO - 'HOME': '/home/cltbld', 09:07:47 INFO - 'LANG': 'en_US.UTF-8', 09:07:47 INFO - 'LANGUAGE': 'en_US:en', 09:07:47 INFO - 'LOGNAME': 'cltbld', 09:07:47 INFO - 'MAIL': '/var/mail/cltbld', 09:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:47 INFO - 'MOZ_NO_REMOTE': '1', 09:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:47 INFO - 'NO_EM_RESTART': '1', 09:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:47 INFO - 'PWD': '/builds/slave/test', 09:07:47 INFO - 'SHELL': '/bin/bash', 09:07:47 INFO - 'SHLVL': '1', 09:07:47 INFO - 'TERM': 'linux', 09:07:47 INFO - 'TMOUT': '86400', 09:07:47 INFO - 'USER': 'cltbld', 09:07:47 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:47 INFO - '_': '/tools/buildbot/bin/python'} 09:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:47 INFO - Running setup.py (path:/tmp/pip-O4Y9Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:47 INFO - Running setup.py (path:/tmp/pip-XpauHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:47 INFO - Running setup.py (path:/tmp/pip-zheKOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:47 INFO - Running setup.py (path:/tmp/pip-ezLD_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:47 INFO - Running setup.py (path:/tmp/pip-L5vSZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:47 INFO - Running setup.py (path:/tmp/pip-o9Ekq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:47 INFO - Running setup.py (path:/tmp/pip-TkUW_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:47 INFO - Running setup.py (path:/tmp/pip-K0yMiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:47 INFO - Running setup.py (path:/tmp/pip-jbPCJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:47 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)) 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:48 INFO - Running setup.py (path:/tmp/pip-uxAEBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:48 INFO - Running setup.py (path:/tmp/pip-zW9xxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:48 INFO - Running setup.py (path:/tmp/pip-oet6Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:48 INFO - Running setup.py (path:/tmp/pip-LIYTL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:48 INFO - Running setup.py (path:/tmp/pip-8n3HwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:48 INFO - Running setup.py (path:/tmp/pip-d0uspp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:48 INFO - Running setup.py (path:/tmp/pip-3jMtje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:48 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)) 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:48 INFO - Running setup.py (path:/tmp/pip-hm7Yv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:48 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)) 09:07:48 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)) 09:07:48 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)) 09:07:48 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)) 09:07:48 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)) 09:07:48 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)) 09:07:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:50 INFO - Downloading blessings-1.6.tar.gz 09:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:50 INFO - Installing collected packages: blessings 09:07:50 INFO - Running setup.py install for blessings 09:07:50 INFO - Successfully installed blessings 09:07:50 INFO - Cleaning up... 09:07:50 INFO - Return code: 0 09:07:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:50 INFO - Reading from file tmpfile_stdout 09:07:50 INFO - Current package versions: 09:07:50 INFO - argparse == 1.2.1 09:07:50 INFO - blessings == 1.6 09:07:50 INFO - blobuploader == 1.2.4 09:07:50 INFO - docopt == 0.6.1 09:07:50 INFO - manifestparser == 1.1 09:07:50 INFO - mozInstall == 1.12 09:07:50 INFO - mozcrash == 0.16 09:07:50 INFO - mozdebug == 0.1 09:07:50 INFO - mozdevice == 0.48 09:07:50 INFO - mozfile == 1.2 09:07:50 INFO - mozhttpd == 0.7 09:07:50 INFO - mozinfo == 0.9 09:07:50 INFO - mozleak == 0.1 09:07:50 INFO - mozlog == 3.1 09:07:50 INFO - moznetwork == 0.27 09:07:50 INFO - mozprocess == 0.22 09:07:50 INFO - mozprofile == 0.28 09:07:50 INFO - mozrunner == 6.11 09:07:50 INFO - mozscreenshot == 0.1 09:07:50 INFO - mozsystemmonitor == 0.0 09:07:50 INFO - moztest == 0.7 09:07:50 INFO - mozversion == 1.4 09:07:50 INFO - psutil == 3.1.1 09:07:50 INFO - requests == 1.2.3 09:07:50 INFO - wsgiref == 0.1.2 09:07:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:50 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:50 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 09:07:50 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 09:07:50 INFO - Using env: {'DISPLAY': ':0', 09:07:50 INFO - 'HOME': '/home/cltbld', 09:07:50 INFO - 'LANG': 'en_US.UTF-8', 09:07:50 INFO - 'LANGUAGE': 'en_US:en', 09:07:50 INFO - 'LOGNAME': 'cltbld', 09:07:50 INFO - 'MAIL': '/var/mail/cltbld', 09:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:50 INFO - 'MOZ_NO_REMOTE': '1', 09:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:50 INFO - 'NO_EM_RESTART': '1', 09:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:50 INFO - 'PWD': '/builds/slave/test', 09:07:50 INFO - 'SHELL': '/bin/bash', 09:07:50 INFO - 'SHLVL': '1', 09:07:50 INFO - 'TERM': 'linux', 09:07:50 INFO - 'TMOUT': '86400', 09:07:50 INFO - 'USER': 'cltbld', 09:07:50 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:50 INFO - '_': '/tools/buildbot/bin/python'} 09:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 INFO - Cleaning up... 09:07:51 INFO - Return code: 0 09:07:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:51 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:51 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 09:07:51 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 09:07:51 INFO - Using env: {'DISPLAY': ':0', 09:07:51 INFO - 'HOME': '/home/cltbld', 09:07:51 INFO - 'LANG': 'en_US.UTF-8', 09:07:51 INFO - 'LANGUAGE': 'en_US:en', 09:07:51 INFO - 'LOGNAME': 'cltbld', 09:07:51 INFO - 'MAIL': '/var/mail/cltbld', 09:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:51 INFO - 'MOZ_NO_REMOTE': '1', 09:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:51 INFO - 'NO_EM_RESTART': '1', 09:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:51 INFO - 'PWD': '/builds/slave/test', 09:07:51 INFO - 'SHELL': '/bin/bash', 09:07:51 INFO - 'SHLVL': '1', 09:07:51 INFO - 'TERM': 'linux', 09:07:51 INFO - 'TMOUT': '86400', 09:07:51 INFO - 'USER': 'cltbld', 09:07:51 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:51 INFO - '_': '/tools/buildbot/bin/python'} 09:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:51 INFO - Downloading/unpacking jsonschema 09:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:53 INFO - Downloading/unpacking functools32 (from jsonschema) 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:53 INFO - warning: no files found matching '*.txt' 09:07:53 INFO - no previously-included directories found matching 'build' 09:07:53 INFO - no previously-included directories found matching 'dist' 09:07:53 INFO - no previously-included directories found matching '.git*' 09:07:53 INFO - Installing collected packages: jsonschema, functools32 09:07:53 INFO - Running setup.py install for functools32 09:07:53 INFO - warning: no files found matching '*.txt' 09:07:53 INFO - no previously-included directories found matching 'build' 09:07:53 INFO - no previously-included directories found matching 'dist' 09:07:53 INFO - no previously-included directories found matching '.git*' 09:07:53 INFO - Successfully installed jsonschema functools32 09:07:53 INFO - Cleaning up... 09:07:53 INFO - Return code: 0 09:07:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:07:53 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')]} 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:53 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')]} 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:53 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 0x7f01ed3d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17223b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', '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 09:07:53 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 09:07:53 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 09:07:53 INFO - Using env: {'DISPLAY': ':0', 09:07:53 INFO - 'HOME': '/home/cltbld', 09:07:53 INFO - 'LANG': 'en_US.UTF-8', 09:07:53 INFO - 'LANGUAGE': 'en_US:en', 09:07:53 INFO - 'LOGNAME': 'cltbld', 09:07:53 INFO - 'MAIL': '/var/mail/cltbld', 09:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:53 INFO - 'MOZ_NO_REMOTE': '1', 09:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:53 INFO - 'NO_EM_RESTART': '1', 09:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:53 INFO - 'PWD': '/builds/slave/test', 09:07:53 INFO - 'SHELL': '/bin/bash', 09:07:53 INFO - 'SHLVL': '1', 09:07:53 INFO - 'TERM': 'linux', 09:07:53 INFO - 'TMOUT': '86400', 09:07:53 INFO - 'USER': 'cltbld', 09:07:53 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:53 INFO - '_': '/tools/buildbot/bin/python'} 09:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:53 INFO - Downloading/unpacking flake8 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:07:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:07:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:07:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:07:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:07:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:07:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:07:56 INFO - no previously-included directories found matching 'docs/_build' 09:07:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:07:56 INFO - Running setup.py install for pep8 09:07:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:07:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:07:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:07:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:07:56 INFO - no previously-included directories found matching 'docs/_build' 09:07:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:07:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:07:56 INFO - Cleaning up... 09:07:56 INFO - Return code: 0 09:07:56 INFO - Running post-action listener: _resource_record_post_action 09:07:56 INFO - Running post-action listener: _start_resource_monitoring 09:07:56 INFO - Starting resource monitoring. 09:07:56 INFO - ##### 09:07:56 INFO - ##### Running install step. 09:07:56 INFO - ##### 09:07:56 INFO - Running pre-action listener: _resource_record_pre_action 09:07:56 INFO - Running main action method: install 09:07:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:56 INFO - Reading from file tmpfile_stdout 09:07:56 INFO - Detecting whether we're running mozinstall >=1.0... 09:07:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:07:56 INFO - Reading from file tmpfile_stdout 09:07:56 INFO - Output received: 09:07:56 INFO - Usage: mozinstall [options] installer 09:07:56 INFO - Options: 09:07:56 INFO - -h, --help show this help message and exit 09:07:56 INFO - -d DEST, --destination=DEST 09:07:56 INFO - Directory to install application into. [default: 09:07:56 INFO - "/builds/slave/test"] 09:07:56 INFO - --app=APP Application being installed. [default: firefox] 09:07:56 INFO - mkdir: /builds/slave/test/build/application 09:07:56 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'] 09:07:56 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 09:08:12 INFO - Reading from file tmpfile_stdout 09:08:12 INFO - Output received: 09:08:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:08:12 INFO - Running post-action listener: _resource_record_post_action 09:08:12 INFO - ##### 09:08:12 INFO - ##### Running run-tests step. 09:08:12 INFO - ##### 09:08:12 INFO - Running pre-action listener: _resource_record_pre_action 09:08:12 INFO - Running main action method: run_tests 09:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:12 INFO - Python 2.7.3 09:08:12 INFO - Return code: 0 09:08:12 INFO - grabbing minidump binary from tooltool 09:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:12 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 0x17b1100>, '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 0x17b2000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b2490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:12 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 09:08:12 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 09:08:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:12 INFO - Return code: 0 09:08:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:08:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:08:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:08:13 INFO - Return code: 0 09:08:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:08:13 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:08:13 INFO - Using env: {'DISPLAY': ':0', 09:08:13 INFO - 'HOME': '/home/cltbld', 09:08:13 INFO - 'LANG': 'en_US.UTF-8', 09:08:13 INFO - 'LANGUAGE': 'en_US:en', 09:08:13 INFO - 'LOGNAME': 'cltbld', 09:08:13 INFO - 'MAIL': '/var/mail/cltbld', 09:08:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:13 INFO - 'MOZ_NO_REMOTE': '1', 09:08:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:13 INFO - 'NO_EM_RESTART': '1', 09:08:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:13 INFO - 'PWD': '/builds/slave/test', 09:08:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:13 INFO - 'SHELL': '/bin/bash', 09:08:13 INFO - 'SHLVL': '1', 09:08:13 INFO - 'TERM': 'linux', 09:08:13 INFO - 'TMOUT': '86400', 09:08:13 INFO - 'USER': 'cltbld', 09:08:13 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621', 09:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:13 INFO - '_': '/tools/buildbot/bin/python'} 09:08:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:08:14 INFO - mozversion application_buildid: 20160229082815 09:08:14 INFO - mozversion application_changeset: 6af962bff65de440a88387256ce311c5e5e2e440 09:08:14 INFO - mozversion application_display_name: Nightly 09:08:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:14 INFO - mozversion application_name: Firefox 09:08:14 INFO - mozversion application_remotingname: firefox 09:08:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:08:14 INFO - mozversion application_vendor: Mozilla 09:08:14 INFO - mozversion application_version: 47.0a1 09:08:14 INFO - mozversion platform_buildid: 20160229082815 09:08:14 INFO - mozversion platform_changeset: 6af962bff65de440a88387256ce311c5e5e2e440 09:08:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:08:14 INFO - mozversion platform_version: 47.0a1 09:08:14 INFO - using testdate: 1456765694 09:08:14 INFO - actual date: 1456765694 09:08:14 INFO - starting webserver on 'localhost:58349' 09:08:14 INFO - SUITE-START | Running 2 tests 09:08:14 INFO - TEST-START | dromaeo_css 09:08:14 INFO - operating with platform_type : linux_ 09:08:14 INFO - Initialising browser for dromaeo_css test... 09:08:14 INFO - TEST-INFO | started process 13314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphVZLLR/profile http://localhost:58349/getInfo.html) 09:08:18 INFO - PROCESS | 13314 | 09:08:18 INFO - PROCESS | 13314 | (process:13396): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:08:19 INFO - PROCESS | 13314 | __metrics Screen width/height:1600/1200 09:08:19 INFO - PROCESS | 13314 | colorDepth:24 09:08:19 INFO - PROCESS | 13314 | Browser inner width/height: 1024/697 09:08:19 INFO - PROCESS | 13314 | __metrics 09:08:19 ERROR - PROCESS | 13314 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:19 INFO - PROCESS | 13314 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:08:20 INFO - TEST-INFO | 13314: exit 0 09:08:20 INFO - Browser initialized. 09:08:20 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:20 INFO - TEST-INFO | started process 13447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphVZLLR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:22 INFO - PROCESS | 13447 | 09:08:22 INFO - PROCESS | 13447 | (process:13504): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:08:32 INFO - PROCESS | 13447 | RSS: Main: 160972800 09:08:32 INFO - PROCESS | 13447 | 09:09:22 INFO - PROCESS | 13447 | 1456765762337 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] 09:11:33 INFO - PROCESS | 13447 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58349/tests/dromaeo/cssquery-ext.html) 09:11:34 INFO - PROCESS | 13447 | RSS: Main: 168292352 09:11:34 INFO - PROCESS | 13447 | 09:14:36 INFO - PROCESS | 13447 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-ext.html (next: http://localhost:58349/tests/dromaeo/cssquery-jquery.html) 09:14:37 INFO - PROCESS | 13447 | RSS: Main: 164974592 09:14:37 INFO - PROCESS | 13447 | 09:17:39 INFO - PROCESS | 13447 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58349/tests/dromaeo/cssquery-mootools.html) 09:17:39 INFO - PROCESS | 13447 | RSS: Main: 166109184 09:17:39 INFO - PROCESS | 13447 | 09:20:41 INFO - PROCESS | 13447 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58349/tests/dromaeo/cssquery-prototype.html) 09:20:42 INFO - PROCESS | 13447 | RSS: Main: 163942400 09:20:42 INFO - PROCESS | 13447 | 09:23:44 INFO - PROCESS | 13447 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58349/tests/dromaeo/cssquery-yui.html) 09:23:45 INFO - PROCESS | 13447 | RSS: Main: 164458496 09:23:45 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | Cycle 1(1): loaded http://localhost:58349/tests/dromaeo/cssquery-yui.html (next: http://localhost:58349/tests/dromaeo/cssquery-dojo.html) 09:26:47 INFO - PROCESS | 13447 | RSS: Main: 168710144 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | __start_tp_report 09:26:47 INFO - PROCESS | 13447 | _x_x_mozilla_page_load 09:26:47 INFO - PROCESS | 13447 | _x_x_mozilla_page_load_details 09:26:47 INFO - PROCESS | 13447 | |i|pagename|runs| 09:26:47 INFO - PROCESS | 13447 | |0;dojo.html;2629.5266851966644;2649.509840679473;2689.0319484985403;2694.5958106284056;2706.0393560286097;4658.90682186356;4675.976620116903;4690.296455531668;4707.529247075295;4739.5023522530155;4556.749378784166;4634.467036290827;4698.483166851652;4708.199606066968;4802.735849528274;4317.244482215608;4407.603315701586;4414.668899832509;4418.690691651585;4423.270160423543;485.03481742362544;4133.379993001044;4225.535191128974;4257.526504559886;4332.090261045184;4213.641840443551;4281.529031806499;4292.527821939584;4316.072044510414;4377.781110944472;4303.784810759449;4317.913641727179;4318.719283246579;4322.524522302544;4358.346248062816;4266.871993840159;4300.978495107535;4316.784160791948;4320.762358070305;4347.934780978288;4528.660350473728;4594.287885377738;4599.632029437637;4612.008418190106;4638.1883170445035;4925.7783399747095;4991.97664478781;4994.650374473788;5000.974995125001;5045.621578381636;4844.75776211188;4983.177775667011;5032.62255330848;5045.899082018339;5083.059633967728;4651.953480465219;4663.976680116578;4671.976640116778;4672.859814205579;4684.110019096429;4975.527324904128;5101.20931255656;5101.668391554611;5113.181890897513;5151.5621172200035;4819.831305904347;4864.73243971585;4876.268559716;4893.363862697826;4912.680675756136;4919.262110683426;4922.507749225048;4929.112759703288;4937.1606826839525;4961.305417241589;4774.618030557547;4870.464248932614;4872.731999740048;4894.070126675921;4924.261360795909;4991.051700176955;4991.750412479434;5001.599872010231;5009.198528235464;5065.062963351792;4184.330507118846;4196.328587425997;4208.22147902639;4222.4933008038615;4226.957730422657;3569.839357228879;3577.409727395003;3642.961755899556;3677.3748462761396;3737.1591391936595;4191.937120943188;4279.486461624625;4315.050688848449;4324.8486302979245;4333.1766964276685;4960.702357858468;5005.624578156653;5010.423801262901;5015.22264049073;5063.367079115111;4221.598948099926;4306.3325184595815;4326.913461730748;4346.369776382407;4385.802638881258;4467.977660111744;4512.842050528216;4514.909701806011;4520.593146616755;4553.408056952575;4683.648726345469;4707.882302942454;4725.078609671081;4727.621790256771;4733.644976626836;4895.46149923501;4934.18585933317;5001;5006.424261210008;5056.216286475602;4703.129920964496;4742.193827049479;4750.691205071659;4758.095961767392;4797.4482934462985;4910.189818679878;4910.533499317559;4940.283658869372;4941.258811178352;4971.37857767779;4857.53853383928;4966.081274964144;4987.077390682735;4997.900041999067;5022.648414610942;4814.398200224972;4831.661783675109;4836.782344794563;4847.587955023862;4893.070316639827;4843.24929635907;4843.806247750051;4847.418309802846;4847.466778654275;4872.610191184625;4580.152671755736;4644.396228490275;4718.575328220477;4724.811007559659;4754.643401744952;4818.277258411266;4842.685225460334;4882.389701287339;4888.1690112681645;4918.95081049185;4750.311204875343;4757.928631070467;4766.142094423037;4771.427428708438;4821.349117869183 09:26:47 INFO - PROCESS | 13447 | |1;ext.html;499.29599265036285;509.79353361888434;511.6290689250294;515.9148740457824;530.7054584705489;32477.188070298253;32918.50622240662;33039.83480082602;33139.50290745638;33180.50229246563;36174.45738313921;36757.44863827045;36757.63242367576;36846.8157659212;36910.75526314468;7747.2640099190485;7951.284384405402;7962.044554653449;8018.959905200466;8019;7790;7859.371250299962;7896.8815467767745;7907.6046197690175;7909.288164065233;7814.3357814585825;7886.369090472777;7900.249476299742;7902.881456778125;7906.407019473534;7825.5304681719;7883.290503854623;7905.130435652074;7919.762407127795;7932.484388514728;7773.416993725493;7798.454108212427;7871.52770833746;7886.763397098096;7898.447108702393;37034.81482592597;37440;37488.00095992314;37569.812150939346;37578.624213758056;2062.804033616804;2728.31792051987;2752.3394385347574;3076.6923307669276;3235.4014507316224;25099.62350564743;25151.87424062868;25241.495170096678;25424.36439089019;25854.224373268833;3039.5592639067213;3050.2526880914097;3058.0825752274227;3118.9220269493217;3159.7472202223767;149663;150104.249478753;150210;150695;150784;38763.612363876004;46184.76907615441;46276.53723462722;46403;46431.76784116058;36710.63289367125;36850.447243291375;36922;37017.074573135884;37116;11716.179867409199;11900.821487677691;11930.522779088913;11934.641960741192;11959.103067269989;9075.682351117679;9210.585523651453;9222.492762898106;9229.16937475617;9243.075692430837;12663.240205587694;12839.807402888964;13214.471421143238;13226.537071202461;13341.066125371131;5965.701714914237;6049.879002420015;6080.118382834465;6104.328523862371;6104.694765261719;869.1873098652779;889.4840992224495;909.3952521573212;947.1475671895212;999.2555546118189;25979.870100649754;26114.608280875804;26210.475790484466;26446.735532644427;26473.735262647126;997.217184510156;1006.8036732837173;1034.4569101221919;1038.2939601071193;1066.1151244467073;13470.854977327037;13582.459599127595;13692.65768355799;14077;14080.577582672537;259129.26965842687;261137;261689;261706;264490;45398;45861.08277834491;46033.539664603595;46055.53944460512;46148.76925615351;1161.4599211366756;1172.2439026827649;1181.1554738362113;1186.0748616079472;1195.8804119587971;24786.50426991414;25824.22527324183;25864.8706756465;26034.869825650752;26270.343241419116;40022.1995560093;40025.39961900632;40240.1951960965;40270.19459610733;40457.59542404656;243268;244639;244658;245369;246052;29571.26071848221;29723.405531889675;30044.549331759605;30505.847470762503;30580.541291881083;38585.49194302361;38845.223095538495;39444.60555394409;39517.40723889087;39596.2080758389;33307.16732081717;33364.33271334511;33415.16462088467;33509.497357540145;33589.83205084057;30531.694683052887;31969.520457193626;32159;32439.513407299382;32526.674733252363;33771;34018.489722654675;35289;36519.45220821637;36534.45198321974;28205;30246.243843903198;30839.383212336077;30845.691543084282;30917.536236956013;23615.40961475977;23706.170284039978;24137.51724965526;24140;24239.151629692875 09:26:47 INFO - PROCESS | 13447 | |2;jquery.html;323.2597352063773;331.6716450713793;336.50533715438297;339.5500961226375;341.4690156806167;14677.70644587109;15181.696366072672;15685.686286274267;15780.447684331051;15795.289211985459;14393.06445081069;14528.564143075699;14760;14950.028248163862;15540.533783986499;4812.783424745886;4965.7020578765205;4988.152014157602;4999.025190087934;5005.899882002358;4809.807607695688;4944;4997.725125118117;5004.649674522785;5029.874253143683;4975.552200301972;4988.65079444439;4991;4992.400911890578;4993.950060499403;4930.605551555885;4933.432655244639;4937.7777999990085;6147.815565533041;6344.555881088326;6045.6674882881425;6110.450059494667;6146.323904370515;6150.66171360575;6155;20318.79681203184;21036.684449733268;21037.78962210389;21041.47396315089;21189.364319070453;1920.9231630734894;1926.489480287725;1967.1737870094594;1968.4389948864648;2053.815156635895;12760.617181484571;13431.731365372638;13774.586762397144;13847.653808654764;14267.500637477742;1867.4117652939417;1892.1863598652574;1901.1141366687618;1901.3820508334848;1952.3166891587973;45702.314465283045;50604.74697626488;57038;62751.686241568954;63915.360846391406;14757.893158013192;16165.191740412933;16189.919050404907;16287.267072981744;16398.09810460436;23304.65043024356;23317.41706457352;23580.528389432115;23665.645015324782;23705.644415333783;7868.921310786934;7922.564258965812;8072.556009419538;8125.512469251864;8157.67369305233;6633.701483433257;6724.9327506725285;6730.427913627396;6864.24493305736;6944.02783610295;7693.307602315818;7790.688372465038;7795.961020194863;7892.763217103496;7903.486273392211;3046.5277881928337;3099.8140111592925;3143.842807859598;3167.920801979923;3297.5383446317533;835.7492752174323;842.8019415437367;906.2659246010752;914.0083009934162;938.8357037518407;15132;15619;15715.214239288218;15787.842121578637;16218.270177842025;868.6959564152622;884.4074470105045;894.673444192865;933.9766505837273;941.9387739796891;8710.520921349387;8922.598483068277;8952.209558088278;8988.325875559229;9082.818343633091;346319;353017;362078;370200;374265;63681.36318636847;63781.68109159425;64208.394790129685;64268.67865660642;65119;928.0672923711761;928.4336554701626;929.2426672262085;933.780561568031;941.5998200764648;13792.862071379157;13836.169829810244;14096.154230746188;14192.858071419154;14437.566872993826;29440.263993400335;30742.231444214074;30820;31011.84494077515;31672.524912125875;39206;41000.179996400504;41910.58089419189;41963.7901810489;42238.366424504275;6463.612183269019;6691.5315927884585;6728.966355168389;6782.491313151435;6837.316268373322;8880.955595221982;10102.343347682377;10127.594896204364;10683.732906677395;10694.358338499404;9498.95250523743;9504.762380940532;9506.572204250964;9548.85676714836;9727.464989425649;9123.817523649623;9497.810043798947;9644.421334719938;9733.9026609733;9792.755181120529;9594.232461402931;9637.759056023655;9656.22750179998;9803.80392392134;9927.106560409598;6919.619420931897;6965.094537710268;6968.6864091115;7011.368976792113;7184;8669.263112635497;8728.563571821256;8742.300615950582;8874.911250887408;9809.264305177283 09:26:47 INFO - PROCESS | 13447 | |3;mootools.html;1338.3575883575884;1344.5294147048535;1454.5490897821676;1702.889312194708;1722.5693576605856;5884.411558844114;6846.212685541164;6997.685104170312;7167.390771784398;7200.747973820918;6938.9653051734795;6945.097137372135;6949.166100067986;6956.791296261107;6964.268751781066;2081.0635214153617;2083.312506872736;2105.9368218953377;2108.620448319302;2111.028926693715;1995.281698588507;2046.3758553641132;2051.897405129745;2079.979200208001;2085.8957052147407;2029.989850050755;2033.379819155157;2033.5322875738589;2033.613613413454;2038.2254743197564;2028.9753674394483;2035.3283416472602;2036.5417780999305;2039.4901274681329;2043.2439997200981;1997.1711739628038;2017.8083082107323;2072.3057775645175;2088.540521085374;2091.9477013074643;6956.721731130749;6964.4080253178545;6993.0908981832545;7023;7033.824154396129;4090.509138903321;4211.410402543646;4213.5786421357925;4226.78866056699;4227.302495088306;2676.6118912757543;2767.4188420431733;2785.387214812738;2793.1201671473423;2793.7625301849366;841.6170642357713;855.2644725536034;866.9349798765118;867.9783005424852;893.6916763716507;9383.390079644802;9433.716988490356;9469.66856160031;9488.193503552206;9543.188828949547;3826.9234615307537;3898.746581472252;3899.6490315871706;3950.762954222698;3959.584243654375;8205.835883282301;8231.34149268057;8246.299064579458;8266.710665126691;8274.917250827535;4249.532551419341;4252.043290259729;4267.4025636410925;4269.978650106792;4274.700770946066;3156.921076973094;3710.8330125144435;3790.3935370340614;3796.069962859062;3797.3354662933875;3259.983700081532;3324.0194142727955;3334.9166270843425;3337.098983274551;3338.2822693121097;1074.7420619051372;1114.7491814341709;1116.4585176189541;1118.2675347647305;1124.0221007723333;910.0035461170008;996.7906739584769;1143.588308209044;1174.6241202815188;1175.5532897498895;6518.348165183444;6519.8696026079215;6539.574927629689;6544.7382104716235;6567.113439685677;1042.3172821801732;1047.3401756893109;1054.4358768059205;1085.6091806949491;1088.7169335972546;5212.661177023481;5248.685078895279;5275.762590683428;5290.761915713802;5299.311089558333;8056.436049476598;8459.196376344238;8493.193146651058;8504.532250726146;8532.317414606816;8354;8362.707305244287;8395.496270223806;8398.286145677564;8434.62044208012;6580.21037475506;6677.499187560952;6749.527533072638;6766.695498702472;6773.8983915241315;6389.2971773105855;6398.296187419473;6400.423961843457;6402.199725034371;6501.642409667514;7373.410127189704;7638.732644357421;7705.383569314554;7770.300672939463;7791.142974272939;7311.524750891175;7526.435517336331;7529.058867641545;7531.774046778605;7757.495762775401;5196.818111366084;5971.58198926071;5984.760609575568;6069.423404776539;6084.969575152096;6642.90035649456;6644;6708.161479815023;6718.361755633207;6724.630145342053;5937.910931335947;6033.095035744674;6054.485368743706;6178.783742568989;6200.534959878118;5712.65724056558;5779.768809247751;5871.354151043296;6063.878722425438;6075.2405949256345;5982.88034239304;6361.9502782040445;6466.256380516301;6490.415862572391;6504.252011018604;5984;5987.520998320037;5989.820305390671;5999.340072592098;6001.339852616296;6012.188354572252;6018.638881667114;6038.365971572922;6053.545984051302;6146.661933593696 09:26:47 INFO - PROCESS | 13447 | |4;prototype.html;285.6900263214412;297.2598230406289;301.6094158065305;303.99088027359176;306.01768323680983;5700.800471983476;5713.45722156395;5772.018756811347;5802;5828.9417105828925;5690.975624387608;5698.259226300585;5704.201411802351;5706.087026075828;5719.656820590768;4099.836006559742;4212.925703945505;4308.030693094061;4311.655067594601;4331.220380331539;4257.276263035292;4298.914021719564;4314.460692413449;4318.654507639397;4320.135972805436;4288.764117973526;4317.870463886088;4318;4321.114171594815;4330.805113769888;4296.462942132233;4326.199653064194;4330.891727706817;4337.457817772778;4339.696221264513;3782.3191825471404;3790.962090379116;3793.791341476218;3796.354619714655;3799.8480060797533;5425.131978883399;5429.321334833146;5437.34751829783;5445.646033007882;5462.945370546323;4711.717296962193;4870.7564621769125;4891.144049791273;4927.113119638464;5029.572486338666;5946.286445626509;5964.582479226456;5974.731137098841;6036.849078773022;6042.425969532887;3982.522097348308;3996.3406038003695;3998.3402738548107;4000.8399664013405;4000.9997500624845;6238.407351301619;6265.248170219557;6307.463865571432;6322.683865806691;6328.620282783002;4075.9810047488127;4104.651104656137;4107.691923105779;4108.91782164361;4118.19695159447;4063.39049142631;4156.168766246763;4159.625633692982;4167.5207351154395;4168.520620128724;4822.083804077214;4865.0756356292195;4869.780859861315;4877.487863774323;4881.389826271716;5964;6011.158437818709;6020.789272375446;6024.698765061729;6025.096235564701;1454.5999850041112;1467.523055007127;1471.5511768910585;1476.970460590782;1477.5050358129931;944.1031020530523;945.177695405002;960.8846938367301;989.618996686281;990.7374545745383;5142.30578871855;5153.175491921274;5170.793168273227;5204.73976301191;5206.869828254324;6190.133381326618;6243.906341404882;6248.0003199487865;6248.687565621792;6254.499640028786;5019.799208031638;5101.69389836611;5202.71385073817;5204;5208.479152084837;3350.966490335114;3382.2728113455723;3394.8132852692843;3405.744569157323;3413.6245013048547;5894.440028197314;5939.762409503658;5947.583669143205;5953.255843019622;5967.19442875215;6442.323556026643;6471.158749362553;6476.158099447041;6483.222013358427;6487.610743355413;5764.250647415809;5854.268216472941;5887.646741195542;5897.410258974069;5899.616524925866;6072.908906366496;6320.936790632035;6323.810285691437;6325.525585581007;6345.1434056401795;6181.752729890754;6190.907136392868;6193.349698281796;6233.470155036873;6247;5847.298324201123;5921.792737254348;5927.614705044159;5937.406259374201;5940.138679891305;4030.91938161241;4039.979800100981;4073.4704488416314;4084.5302790179508;4085.3054980653956;6090.969545152246;6171.074338849208;6239.251289845248;6301.338359472189;6301.369863013662;6020.247469066367;6030.6080104793045;6051.727672254671;6062.909056364247;6068.120122582289;6040.939590604214;6043.848903777265;6051.425114614281;6053.485453736482;6073.605215660968;5914.881702366015;5915.40845915405;5920.082387229986;5927.436893495111;5935.169076329404;5931.584789064724;6066.848328791815;6091.269047714302;6092.055731361646;6120.632762034292;5899.705014749331;5925.318588362394;5927.792527261525;5933.792317268875;5939.4357536034 09:26:47 INFO - PROCESS | 13447 | |5;yui.html;564.2608183279904;564.96327738697;697.0067653593628;709.7835160276115;711.8397012869025;10581.894181058187;10830.566777328908;10894.40080795557;10897.509612067457;10991.230613857013;11218.270812397188;11237.60668376607;11242.718932026703;11246.49390777415;11267.943660281708;593.5637306579661;755.6712829918989;760.9467337286392;772.1622040086513;776.1036003416064;749.7525816480576;760.0461420916741;764.6176911544228;765.2577000309691;770.433731207562;806.5644551941945;814.0150417994234;815.2499700275731;817.4114637461018;818.6029775558849;802.4142376065475;804.9436539442241;805.0621026504116;806.3025482957229;807.9838403231931;603.7916918663054;606.3178923710825;606.5693357716027;607.6202373516552;608.5800797449746;10903.672889813319;10957.12343012557;10969.122470202365;11005.504752286086;11042.723931901686;11598.652040438801;11779.587714429954;11919.344436056013;12112.697182570419;12186;9385.483798391086;9470.526877910244;9650;9654.90345096547;9723.65967191152;3270.4767237242163;3296.1924328539662;3332.750043746729;3333.2500187457626;3412.2663627320244;39998;40120;40129;40309;40456.59543404558;8776.297896168291;9127.90872091284;9163.81672366549;9193.49435781025;9200.263978881674;16445.25996330168;16512.25694843735;16579.088150151856;16622.833771662372;16639.584010399594;6245.188125543741;6328.240611126602;6425.714857028613;6442.645654489048;6493.188351456068;3641.089727568108;3658.32321020612;3691.7046636269033;3743.9064023399087;3746.793926334023;2515.471750932288;2541.9491610167693;2548.5030419068103;2567.537843188244;2571.6528268683865;435.5165765999738;439.25765456378616;447.8007286757427;453.81620443720345;454.33666846404617;439.65047787009405;590.8138936235072;605.2457942858869;618.811262564913;656.8620589676126;7412.258774122544;7537.472376933562;7657.617119144021;7736.381089512825;8068.878966815502;584.8654809393863;587.7854583077146;597.4082586985809;606.1029676079427;621.8134559632092;3237.8542965566608;3593.6765691087926;3670.724695647837;3693.963060369416;3743.7192210584317;49233.26150107751;49514;49681.50318496769;49962.750186248835;50230.49769502258;47857.521424786006;47933.52066479291;48126.27810582844;49055.509444905096;49157.50842491529;40711.79644101761;40908.59091409107;40962.79518602447;41000.38499422511;41715.79142104331;7836.294733474015;8115.350771938349;8656.523891186045;8670.046294907681;8769.868451973352;31031.689683103785;31291.374172516877;31422;31893.20266993344;32230.19424514406;36808.44787328139;37508.624913750515;38464;39287.41068883912;39871.80064099661;9521.57152928106;9605.519724013911;9702.078302561245;9775.85336219943;9934.552945117632;9416.529173541432;9681.757956051155;10529.315594486334;10735.731606709895;10800.189985750943;9325.906740932503;9437.57530911097;9541.427514349161;9696.17582505495;10479;8935.693479722264;9018.549072546215;9115.726528204164;9174.128457796498;10444.216683748597;10054.949725251327;10156.238282129018;10165.542550585093;10186.137826486683;10219.335743176669;8533.445326053787;8613.26787223093;8735.737927862174;8890.39161478933;9416.905830941603;8664.220220180214;8727.389082764146;9049.366544341832;9096.727098187064;9228.815423691354 09:26:47 INFO - PROCESS | 13447 | __end_tp_report 09:26:47 INFO - PROCESS | 13447 | __start_cc_report 09:26:47 INFO - PROCESS | 13447 | _x_x_mozilla_cycle_collect,348 09:26:47 INFO - PROCESS | 13447 | __end_cc_report 09:26:47 INFO - PROCESS | 13447 | __startTimestamp1456766807813__endTimestamp 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | ------- Summary: start ------- 09:26:47 INFO - PROCESS | 13447 | Number of tests: 6 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | [#0] dojo.html Cycles:165 Average:4583.02 Median:4739.50 stddev:569.33 (12.0%) stddev-sans-first:550.07 09:26:47 INFO - PROCESS | 13447 | Values: 2629.5 2649.5 2689.0 2694.6 2706.0 4658.9 4676.0 4690.3 4707.5 4739.5 4556.7 4634.5 4698.5 4708.2 4802.7 4317.2 4407.6 4414.7 4418.7 4423.3 485.0 4133.4 4225.5 4257.5 4332.1 4213.6 4281.5 4292.5 4316.1 4377.8 4303.8 4317.9 4318.7 4322.5 4358.3 4266.9 4301.0 4316.8 4320.8 4347.9 4528.7 4594.3 4599.6 4612.0 4638.2 4925.8 4992.0 4994.7 5001.0 5045.6 4844.8 4983.2 5032.6 5045.9 5083.1 4652.0 4664.0 4672.0 4672.9 4684.1 4975.5 5101.2 5101.7 5113.2 5151.6 4819.8 4864.7 4876.3 4893.4 4912.7 4919.3 4922.5 4929.1 4937.2 4961.3 4774.6 4870.5 4872.7 4894.1 4924.3 4991.1 4991.8 5001.6 5009.2 5065.1 4184.3 4196.3 4208.2 4222.5 4227.0 3569.8 3577.4 3643.0 3677.4 3737.2 4191.9 4279.5 4315.1 4324.8 4333.2 4960.7 5005.6 5010.4 5015.2 5063.4 4221.6 4306.3 4326.9 4346.4 4385.8 4468.0 4512.8 4514.9 4520.6 4553.4 4683.6 4707.9 4725.1 4727.6 4733.6 4895.5 4934.2 5001.0 5006.4 5056.2 4703.1 4742.2 4750.7 4758.1 4797.4 4910.2 4910.5 4940.3 4941.3 4971.4 4857.5 4966.1 4987.1 4997.9 5022.6 4814.4 4831.7 4836.8 4847.6 4893.1 4843.2 4843.8 4847.4 4847.5 4872.6 4580.2 4644.4 4718.6 4724.8 4754.6 4818.3 4842.7 4882.4 4888.2 4919.0 4750.3 4757.9 4766.1 4771.4 4821.3 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | [#1] ext.html Cycles:180 Average:37109.51 Median:33389.75 stddev:58517.14 (175.3%) stddev-sans-first:58616.73 09:26:47 INFO - PROCESS | 13447 | Values: 499.3 509.8 511.6 515.9 530.7 32477.2 32918.5 33039.8 33139.5 33180.5 36174.5 36757.4 36757.6 36846.8 36910.8 7747.3 7951.3 7962.0 8019.0 8019.0 7790.0 7859.4 7896.9 7907.6 7909.3 7814.3 7886.4 7900.2 7902.9 7906.4 7825.5 7883.3 7905.1 7919.8 7932.5 7773.4 7798.5 7871.5 7886.8 7898.4 37034.8 37440.0 37488.0 37569.8 37578.6 2062.8 2728.3 2752.3 3076.7 3235.4 25099.6 25151.9 25241.5 25424.4 25854.2 3039.6 3050.3 3058.1 3118.9 3159.7 149663.0 150104.2 150210.0 150695.0 150784.0 38763.6 46184.8 46276.5 46403.0 46431.8 36710.6 36850.4 36922.0 37017.1 37116.0 11716.2 11900.8 11930.5 11934.6 11959.1 9075.7 9210.6 9222.5 9229.2 9243.1 12663.2 12839.8 13214.5 13226.5 13341.1 5965.7 6049.9 6080.1 6104.3 6104.7 869.2 889.5 909.4 947.1 999.3 25979.9 26114.6 26210.5 26446.7 26473.7 997.2 1006.8 1034.5 1038.3 1066.1 13470.9 13582.5 13692.7 14077.0 14080.6 259129.3 261137.0 261689.0 261706.0 264490.0 45398.0 45861.1 46033.5 46055.5 46148.8 1161.5 1172.2 1181.2 1186.1 1195.9 24786.5 25824.2 25864.9 26034.9 26270.3 40022.2 40025.4 40240.2 40270.2 40457.6 243268.0 244639.0 244658.0 245369.0 246052.0 29571.3 29723.4 30044.5 30505.8 30580.5 38585.5 38845.2 39444.6 39517.4 39596.2 33307.2 33364.3 33415.2 33509.5 33589.8 30531.7 31969.5 32159.0 32439.5 32526.7 33771.0 34018.5 35289.0 36519.5 36534.5 28205.0 30246.2 30839.4 30845.7 30917.5 23615.4 23706.2 24137.5 24140.0 24239.2 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | [#2] jquery.html Cycles:180 Average:22698.89 Median:4991.70 stddev:59153.06 (1185.0%) stddev-sans-first:59295.14 09:26:47 INFO - PROCESS | 13447 | Values: 323.3 331.7 336.5 339.6 341.5 14677.7 15181.7 15685.7 15780.4 15795.3 14393.1 14528.6 14760.0 14950.0 15540.5 4812.8 4965.7 4988.2 4999.0 5005.9 4809.8 4944.0 4997.7 5004.6 5029.9 4975.6 4988.7 4991.0 4992.4 4994.0 4930.6 4933.4 4937.8 6147.8 6344.6 6045.7 6110.5 6146.3 6150.7 6155.0 20318.8 21036.7 21037.8 21041.5 21189.4 1920.9 1926.5 1967.2 1968.4 2053.8 12760.6 13431.7 13774.6 13847.7 14267.5 1867.4 1892.2 1901.1 1901.4 1952.3 45702.3 50604.7 57038.0 62751.7 63915.4 14757.9 16165.2 16189.9 16287.3 16398.1 23304.7 23317.4 23580.5 23665.6 23705.6 7868.9 7922.6 8072.6 8125.5 8157.7 6633.7 6724.9 6730.4 6864.2 6944.0 7693.3 7790.7 7796.0 7892.8 7903.5 3046.5 3099.8 3143.8 3167.9 3297.5 835.7 842.8 906.3 914.0 938.8 15132.0 15619.0 15715.2 15787.8 16218.3 868.7 884.4 894.7 934.0 941.9 8710.5 8922.6 8952.2 8988.3 9082.8 346319.0 353017.0 362078.0 370200.0 374265.0 63681.4 63781.7 64208.4 64268.7 65119.0 928.1 928.4 929.2 933.8 941.6 13792.9 13836.2 14096.2 14192.9 14437.6 29440.3 30742.2 30820.0 31011.8 31672.5 39206.0 41000.2 41910.6 41963.8 42238.4 6463.6 6691.5 6729.0 6782.5 6837.3 8881.0 10102.3 10127.6 10683.7 10694.4 9499.0 9504.8 9506.6 9548.9 9727.5 9123.8 9497.8 9644.4 9733.9 9792.8 9594.2 9637.8 9656.2 9803.8 9927.1 6919.6 6965.1 6968.7 7011.4 7184.0 8669.3 8728.6 8742.3 8874.9 9809.3 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | [#3] mootools.html Cycles:180 Average:4898.02 Median:6000.34 stddev:2512.08 (41.9%) stddev-sans-first:2504.88 09:26:47 INFO - PROCESS | 13447 | Values: 1338.4 1344.5 1454.5 1702.9 1722.6 5884.4 6846.2 6997.7 7167.4 7200.7 6939.0 6945.1 6949.2 6956.8 6964.3 2081.1 2083.3 2105.9 2108.6 2111.0 1995.3 2046.4 2051.9 2080.0 2085.9 2030.0 2033.4 2033.5 2033.6 2038.2 2029.0 2035.3 2036.5 2039.5 2043.2 1997.2 2017.8 2072.3 2088.5 2091.9 6956.7 6964.4 6993.1 7023.0 7033.8 4090.5 4211.4 4213.6 4226.8 4227.3 2676.6 2767.4 2785.4 2793.1 2793.8 841.6 855.3 866.9 868.0 893.7 9383.4 9433.7 9469.7 9488.2 9543.2 3826.9 3898.7 3899.6 3950.8 3959.6 8205.8 8231.3 8246.3 8266.7 8274.9 4249.5 4252.0 4267.4 4270.0 4274.7 3156.9 3710.8 3790.4 3796.1 3797.3 3260.0 3324.0 3334.9 3337.1 3338.3 1074.7 1114.7 1116.5 1118.3 1124.0 910.0 996.8 1143.6 1174.6 1175.6 6518.3 6519.9 6539.6 6544.7 6567.1 1042.3 1047.3 1054.4 1085.6 1088.7 5212.7 5248.7 5275.8 5290.8 5299.3 8056.4 8459.2 8493.2 8504.5 8532.3 8354.0 8362.7 8395.5 8398.3 8434.6 6580.2 6677.5 6749.5 6766.7 6773.9 6389.3 6398.3 6400.4 6402.2 6501.6 7373.4 7638.7 7705.4 7770.3 7791.1 7311.5 7526.4 7529.1 7531.8 7757.5 5196.8 5971.6 5984.8 6069.4 6085.0 6642.9 6644.0 6708.2 6718.4 6724.6 5937.9 6033.1 6054.5 6178.8 6200.5 5712.7 5779.8 5871.4 6063.9 6075.2 5982.9 6362.0 6466.3 6490.4 6504.3 5984.0 5987.5 5989.8 5999.3 6001.3 6012.2 6018.6 6038.4 6053.5 6146.7 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | [#4] prototype.html Cycles:180 Average:4939.78 Median:5716.56 stddev:1504.42 (26.3%) stddev-sans-first:1467.53 09:26:47 INFO - PROCESS | 13447 | Values: 285.7 297.3 301.6 304.0 306.0 5700.8 5713.5 5772.0 5802.0 5828.9 5691.0 5698.3 5704.2 5706.1 5719.7 4099.8 4212.9 4308.0 4311.7 4331.2 4257.3 4298.9 4314.5 4318.7 4320.1 4288.8 4317.9 4318.0 4321.1 4330.8 4296.5 4326.2 4330.9 4337.5 4339.7 3782.3 3791.0 3793.8 3796.4 3799.8 5425.1 5429.3 5437.3 5445.6 5462.9 4711.7 4870.8 4891.1 4927.1 5029.6 5946.3 5964.6 5974.7 6036.8 6042.4 3982.5 3996.3 3998.3 4000.8 4001.0 6238.4 6265.2 6307.5 6322.7 6328.6 4076.0 4104.7 4107.7 4108.9 4118.2 4063.4 4156.2 4159.6 4167.5 4168.5 4822.1 4865.1 4869.8 4877.5 4881.4 5964.0 6011.2 6020.8 6024.7 6025.1 1454.6 1467.5 1471.6 1477.0 1477.5 944.1 945.2 960.9 989.6 990.7 5142.3 5153.2 5170.8 5204.7 5206.9 6190.1 6243.9 6248.0 6248.7 6254.5 5019.8 5101.7 5202.7 5204.0 5208.5 3351.0 3382.3 3394.8 3405.7 3413.6 5894.4 5939.8 5947.6 5953.3 5967.2 6442.3 6471.2 6476.2 6483.2 6487.6 5764.3 5854.3 5887.6 5897.4 5899.6 6072.9 6320.9 6323.8 6325.5 6345.1 6181.8 6190.9 6193.3 6233.5 6247.0 5847.3 5921.8 5927.6 5937.4 5940.1 4030.9 4040.0 4073.5 4084.5 4085.3 6091.0 6171.1 6239.3 6301.3 6301.4 6020.2 6030.6 6051.7 6062.9 6068.1 6040.9 6043.8 6051.4 6053.5 6073.6 5914.9 5915.4 5920.1 5927.4 5935.2 5931.6 6066.8 6091.3 6092.1 6120.6 5899.7 5925.3 5927.8 5933.8 5939.4 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | [#5] yui.html Cycles:180 Average:12170.59 Median:25397.38 stddev:14059.53 (55.4%) stddev-sans-first:14071.95 09:26:47 INFO - PROCESS | 13447 | Values: 564.3 565.0 697.0 709.8 711.8 10581.9 10830.6 10894.4 10897.5 10991.2 11218.3 11237.6 11242.7 11246.5 11267.9 593.6 755.7 760.9 772.2 776.1 749.8 760.0 764.6 765.3 770.4 806.6 814.0 815.2 817.4 818.6 802.4 804.9 805.1 806.3 808.0 603.8 606.3 606.6 607.6 608.6 10903.7 10957.1 10969.1 11005.5 11042.7 11598.7 11779.6 11919.3 12112.7 12186.0 9385.5 9470.5 9650.0 9654.9 9723.7 3270.5 3296.2 3332.8 3333.3 3412.3 39998.0 40120.0 40129.0 40309.0 40456.6 8776.3 9127.9 9163.8 9193.5 9200.3 16445.3 16512.3 16579.1 16622.8 16639.6 6245.2 6328.2 6425.7 6442.6 6493.2 3641.1 3658.3 3691.7 3743.9 3746.8 2515.5 2541.9 2548.5 2567.5 2571.7 435.5 439.3 447.8 453.8 454.3 439.7 590.8 605.2 618.8 656.9 7412.3 7537.5 7657.6 7736.4 8068.9 584.9 587.8 597.4 606.1 621.8 3237.9 3593.7 3670.7 3694.0 3743.7 49233.3 49514.0 49681.5 49962.8 50230.5 47857.5 47933.5 48126.3 49055.5 49157.5 40711.8 40908.6 40962.8 41000.4 41715.8 7836.3 8115.4 8656.5 8670.0 8769.9 31031.7 31291.4 31422.0 31893.2 32230.2 36808.4 37508.6 38464.0 39287.4 39871.8 9521.6 9605.5 9702.1 9775.9 9934.6 9416.5 9681.8 10529.3 10735.7 10800.2 9325.9 9437.6 9541.4 9696.2 10479.0 8935.7 9018.5 9115.7 9174.1 10444.2 10054.9 10156.2 10165.5 10186.1 10219.3 8533.4 8613.3 8735.7 8890.4 9416.9 8664.2 8727.4 9049.4 9096.7 9228.8 09:26:47 INFO - PROCESS | 13447 | -------- Summary: end -------- 09:26:47 INFO - PROCESS | 13447 | 09:26:47 INFO - PROCESS | 13447 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:47 INFO - PROCESS | 13447 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:47 INFO - PROCESS | 13447 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:47 INFO - PROCESS | 13447 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:47 INFO - PROCESS | 13447 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:47 INFO - PROCESS | 13447 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:47 INFO - PROCESS | 13447 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:47 INFO - PROCESS | 13447 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:48 INFO - TEST-INFO | 13447: exit 0 09:26:48 INFO - TEST-OK | dromaeo_css | took 1114336ms 09:26:48 INFO - TEST-START | kraken 09:26:48 INFO - operating with platform_type : linux_ 09:26:48 INFO - Initialising browser for kraken test... 09:26:48 INFO - TEST-INFO | started process 13686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zJCf8/profile http://localhost:58349/getInfo.html) 09:26:52 INFO - PROCESS | 13686 | 09:26:52 INFO - PROCESS | 13686 | (process:13755): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:26:53 INFO - PROCESS | 13686 | __metrics Screen width/height:1600/1200 09:26:53 INFO - PROCESS | 13686 | colorDepth:24 09:26:53 INFO - PROCESS | 13686 | Browser inner width/height: 1024/697 09:26:53 INFO - PROCESS | 13686 | __metrics 09:26:53 ERROR - PROCESS | 13686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:53 INFO - PROCESS | 13686 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:26:54 INFO - TEST-INFO | 13686: exit 0 09:26:54 INFO - Browser initialized. 09:26:54 INFO - Running cycle 1/1 for kraken test... 09:26:54 INFO - TEST-INFO | started process 13806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zJCf8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:26:56 INFO - PROCESS | 13806 | 09:26:56 INFO - PROCESS | 13806 | (process:13862): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:27:06 INFO - PROCESS | 13806 | RSS: Main: 161140736 09:27:06 INFO - PROCESS | 13806 | 09:27:09 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58349/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:10 INFO - PROCESS | 13806 | RSS: Main: 167256064 09:27:10 INFO - PROCESS | 13806 | 09:27:12 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58349/tests/kraken/driver.html?testName=audio-dft) 09:27:13 INFO - PROCESS | 13806 | RSS: Main: 169734144 09:27:13 INFO - PROCESS | 13806 | 09:27:16 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58349/tests/kraken/driver.html?testName=audio-fft) 09:27:16 INFO - PROCESS | 13806 | RSS: Main: 165552128 09:27:16 INFO - PROCESS | 13806 | 09:27:18 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58349/tests/kraken/driver.html?testName=audio-oscillator) 09:27:19 INFO - PROCESS | 13806 | RSS: Main: 164143104 09:27:19 INFO - PROCESS | 13806 | 09:27:21 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58349/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:22 INFO - PROCESS | 13806 | RSS: Main: 166113280 09:27:22 INFO - PROCESS | 13806 | 09:27:25 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58349/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:26 INFO - PROCESS | 13806 | RSS: Main: 166227968 09:27:26 INFO - PROCESS | 13806 | 09:27:29 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58349/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:30 INFO - PROCESS | 13806 | RSS: Main: 164020224 09:27:30 INFO - PROCESS | 13806 | 09:27:33 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58349/tests/kraken/driver.html?testName=json-parse-financial) 09:27:33 INFO - PROCESS | 13806 | RSS: Main: 164519936 09:27:33 INFO - PROCESS | 13806 | 09:27:35 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58349/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:36 INFO - PROCESS | 13806 | RSS: Main: 164007936 09:27:36 INFO - PROCESS | 13806 | 09:27:37 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:38 INFO - PROCESS | 13806 | RSS: Main: 163844096 09:27:38 INFO - PROCESS | 13806 | 09:27:40 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:41 INFO - PROCESS | 13806 | RSS: Main: 165359616 09:27:41 INFO - PROCESS | 13806 | 09:27:43 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:27:44 INFO - PROCESS | 13806 | RSS: Main: 165343232 09:27:44 INFO - PROCESS | 13806 | 09:27:47 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:47 INFO - PROCESS | 13806 | RSS: Main: 165707776 09:27:47 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:58349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58349/tests/kraken/driver.html?testName=ai-astar) 09:27:49 INFO - PROCESS | 13806 | RSS: Main: 166436864 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | __start_tp_report 09:27:49 INFO - PROCESS | 13806 | _x_x_mozilla_page_load 09:27:49 INFO - PROCESS | 13806 | _x_x_mozilla_page_load_details 09:27:49 INFO - PROCESS | 13806 | |i|pagename|runs| 09:27:49 INFO - PROCESS | 13806 | |0;ai-astar;115;111;115;115;115;126;114;114;115;115 09:27:49 INFO - PROCESS | 13806 | |1;audio-beat-detection;157;139;159;165;135;154;152;132;183;134 09:27:49 INFO - PROCESS | 13806 | |2;audio-dft;165;166;163;165;164;170;165;163;167;163 09:27:49 INFO - PROCESS | 13806 | |3;audio-fft;78;74;73;74;79;147;74;73;73;75 09:27:49 INFO - PROCESS | 13806 | |4;audio-oscillator;97;98;141;98;99;98;148;98;97;134 09:27:49 INFO - PROCESS | 13806 | |5;imaging-gaussian-blur;120;116;115;116;115;115;115;117;117;115 09:27:49 INFO - PROCESS | 13806 | |6;imaging-darkroom;147;149;150;148;149;148;149;148;148;148 09:27:49 INFO - PROCESS | 13806 | |7;imaging-desaturate;96;96;97;95;96;97;97;98;96;96 09:27:49 INFO - PROCESS | 13806 | |8;json-parse-financial;69;69;68;69;67;68;68;74;67;65 09:27:49 INFO - PROCESS | 13806 | |9;json-stringify-tinderbox;71;72;70;71;72;71;71;78;71;71 09:27:49 INFO - PROCESS | 13806 | |10;stanford-crypto-aes;91;90;91;84;87;86;85;85;85;85 09:27:49 INFO - PROCESS | 13806 | |11;stanford-crypto-ccm;122;124;125;134;136;135;123;124;125;129 09:27:49 INFO - PROCESS | 13806 | |12;stanford-crypto-pbkdf2;146;164;145;150;152;139;153;149;151;138 09:27:49 INFO - PROCESS | 13806 | |13;stanford-crypto-sha256-iterative;73;71;74;75;70;71;72;71;71;72 09:27:49 INFO - PROCESS | 13806 | __end_tp_report 09:27:49 INFO - PROCESS | 13806 | __start_cc_report 09:27:49 INFO - PROCESS | 13806 | _x_x_mozilla_cycle_collect,831 09:27:49 INFO - PROCESS | 13806 | __end_cc_report 09:27:49 INFO - PROCESS | 13806 | __startTimestamp1456766869839__endTimestamp 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | ------- Summary: start ------- 09:27:49 INFO - PROCESS | 13806 | Number of tests: 14 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:3.89 (3.4%) stddev-sans-first:4.13 09:27:49 INFO - PROCESS | 13806 | Values: 115.0 111.0 115.0 115.0 115.0 126.0 114.0 114.0 115.0 115.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:155.50 stddev:16.26 (10.5%) stddev-sans-first:17.10 09:27:49 INFO - PROCESS | 13806 | Values: 157.0 139.0 159.0 165.0 135.0 154.0 152.0 132.0 183.0 134.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.18 (1.3%) stddev-sans-first:2.32 09:27:49 INFO - PROCESS | 13806 | Values: 165.0 166.0 163.0 165.0 164.0 170.0 165.0 163.0 167.0 163.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#3] audio-fft Cycles:10 Average:82.00 Median:74.00 stddev:22.93 (31.0%) stddev-sans-first:24.28 09:27:49 INFO - PROCESS | 13806 | Values: 78.0 74.0 73.0 74.0 79.0 147.0 74.0 73.0 73.0 75.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:98.00 stddev:21.11 (21.5%) stddev-sans-first:21.79 09:27:49 INFO - PROCESS | 13806 | Values: 97.0 98.0 141.0 98.0 99.0 98.0 148.0 98.0 97.0 134.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:116.00 stddev:1.60 (1.4%) stddev-sans-first:0.87 09:27:49 INFO - PROCESS | 13806 | Values: 120.0 116.0 115.0 116.0 115.0 115.0 115.0 117.0 117.0 115.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 09:27:49 INFO - PROCESS | 13806 | Values: 147.0 149.0 150.0 148.0 149.0 148.0 149.0 148.0 148.0 148.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 09:27:49 INFO - PROCESS | 13806 | Values: 96.0 96.0 97.0 95.0 96.0 97.0 97.0 98.0 96.0 96.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:68.50 stddev:2.32 (3.4%) stddev-sans-first:2.45 09:27:49 INFO - PROCESS | 13806 | Values: 69.0 69.0 68.0 69.0 67.0 68.0 68.0 74.0 67.0 65.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.00 stddev:2.25 (3.2%) stddev-sans-first:2.37 09:27:49 INFO - PROCESS | 13806 | Values: 71.0 72.0 70.0 71.0 72.0 71.0 71.0 78.0 71.0 71.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.50 stddev:2.73 (3.2%) stddev-sans-first:2.46 09:27:49 INFO - PROCESS | 13806 | Values: 91.0 90.0 91.0 84.0 87.0 86.0 85.0 85.0 85.0 85.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.00 stddev:5.38 (4.2%) stddev-sans-first:5.29 09:27:49 INFO - PROCESS | 13806 | Values: 122.0 124.0 125.0 134.0 136.0 135.0 123.0 124.0 125.0 129.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:150.50 stddev:7.45 (5.0%) stddev-sans-first:7.84 09:27:49 INFO - PROCESS | 13806 | Values: 146.0 164.0 145.0 150.0 152.0 139.0 153.0 149.0 151.0 138.0 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.56 (2.2%) stddev-sans-first:1.62 09:27:49 INFO - PROCESS | 13806 | Values: 73.0 71.0 74.0 75.0 70.0 71.0 72.0 71.0 71.0 72.0 09:27:49 INFO - PROCESS | 13806 | -------- Summary: end -------- 09:27:49 INFO - PROCESS | 13806 | 09:27:49 INFO - PROCESS | 13806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:49 INFO - PROCESS | 13806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:49 INFO - PROCESS | 13806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:49 INFO - PROCESS | 13806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:49 INFO - PROCESS | 13806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:49 INFO - PROCESS | 13806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:49 INFO - PROCESS | 13806 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:27:50 INFO - TEST-INFO | 13806: exit 0 09:27:50 INFO - TEST-OK | kraken | took 62362ms 09:27:50 INFO - SUITE-END | took 1176s 09:27:50 INFO - Completed test suite (00:19:36) 09:27:50 INFO - Working with test: dromaeo_css 09:27:50 INFO - Generating results file: dromaeo_css 09:27:50 INFO - Working with test: kraken 09:27:50 INFO - Generating results file: kraken 09:27:50 INFO - javascript benchmark 09:27:50 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:27:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 09:27:51 INFO - process_Request line: dromaeo_css 6262.87 graph.html#tests=[[72,132,43]] 09:27:51 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:27:51 INFO - process_Request line: kraken 1560.80 graph.html#tests=[[232,132,43]] 09:27:51 INFO - RETURN: dromaeo_css: 6262.87 09:27:51 INFO - RETURN: kraken: 1560.80 09:27:51 INFO - javascript benchmark 09:27:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.5266851966644, 2649.509840679473, 2689.0319484985403, 2694.5958106284056, 2706.0393560286097, 4658.90682186356, 4675.976620116903, 4690.296455531668, 4707.529247075295, 4739.5023522530155, 4556.749378784166, 4634.467036290827, 4698.483166851652, 4708.199606066968, 4802.735849528274, 4317.244482215608, 4407.603315701586, 4414.668899832509, 4418.690691651585, 4423.270160423543, 485.03481742362544, 4133.379993001044, 4225.535191128974, 4257.526504559886, 4332.090261045184, 4213.641840443551, 4281.529031806499, 4292.527821939584, 4316.072044510414, 4377.781110944472, 4303.784810759449, 4317.913641727179, 4318.719283246579, 4322.524522302544, 4358.346248062816, 4266.871993840159, 4300.978495107535, 4316.784160791948, 4320.762358070305, 4347.934780978288, 4528.660350473728, 4594.287885377738, 4599.632029437637, 4612.008418190106, 4638.1883170445035, 4925.7783399747095, 4991.97664478781, 4994.650374473788, 5000.974995125001, 5045.621578381636, 4844.75776211188, 4983.177775667011, 5032.62255330848, 5045.899082018339, 5083.059633967728, 4651.953480465219, 4663.976680116578, 4671.976640116778, 4672.859814205579, 4684.110019096429, 4975.527324904128, 5101.20931255656, 5101.668391554611, 5113.181890897513, 5151.5621172200035, 4819.831305904347, 4864.73243971585, 4876.268559716, 4893.363862697826, 4912.680675756136, 4919.262110683426, 4922.507749225048, 4929.112759703288, 4937.1606826839525, 4961.305417241589, 4774.618030557547, 4870.464248932614, 4872.731999740048, 4894.070126675921, 4924.261360795909, 4991.051700176955, 4991.750412479434, 5001.599872010231, 5009.198528235464, 5065.062963351792, 4184.330507118846, 4196.328587425997, 4208.22147902639, 4222.4933008038615, 4226.957730422657, 3569.839357228879, 3577.409727395003, 3642.961755899556, 3677.3748462761396, 3737.1591391936595, 4191.937120943188, 4279.486461624625, 4315.050688848449, 4324.8486302979245, 4333.1766964276685, 4960.702357858468, 5005.624578156653, 5010.423801262901, 5015.22264049073, 5063.367079115111, 4221.598948099926, 4306.3325184595815, 4326.913461730748, 4346.369776382407, 4385.802638881258, 4467.977660111744, 4512.842050528216, 4514.909701806011, 4520.593146616755, 4553.408056952575, 4683.648726345469, 4707.882302942454, 4725.078609671081, 4727.621790256771, 4733.644976626836, 4895.46149923501, 4934.18585933317, 5001.0, 5006.424261210008, 5056.216286475602, 4703.129920964496, 4742.193827049479, 4750.691205071659, 4758.095961767392, 4797.4482934462985, 4910.189818679878, 4910.533499317559, 4940.283658869372, 4941.258811178352, 4971.37857767779, 4857.53853383928, 4966.081274964144, 4987.077390682735, 4997.900041999067, 5022.648414610942, 4814.398200224972, 4831.661783675109, 4836.782344794563, 4847.587955023862, 4893.070316639827, 4843.24929635907, 4843.806247750051, 4847.418309802846, 4847.466778654275, 4872.610191184625, 4580.152671755736, 4644.396228490275, 4718.575328220477, 4724.811007559659, 4754.643401744952, 4818.277258411266, 4842.685225460334, 4882.389701287339, 4888.1690112681645, 4918.95081049185, 4750.311204875343, 4757.928631070467, 4766.142094423037, 4771.427428708438, 4821.349117869183], "unit": "score", "name": "dojo.html", "value": 4549.733744642689}, {"lowerIsBetter": false, "replicates": [499.29599265036285, 509.79353361888434, 511.6290689250294, 515.9148740457824, 530.7054584705489, 32477.188070298253, 32918.50622240662, 33039.83480082602, 33139.50290745638, 33180.50229246563, 36174.45738313921, 36757.44863827045, 36757.63242367576, 36846.8157659212, 36910.75526314468, 7747.2640099190485, 7951.284384405402, 7962.044554653449, 8018.959905200466, 8019.0, 7790.0, 7859.371250299962, 7896.8815467767745, 7907.6046197690175, 7909.288164065233, 7814.3357814585825, 7886.369090472777, 7900.249476299742, 7902.881456778125, 7906.407019473534, 7825.5304681719, 7883.290503854623, 7905.130435652074, 7919.762407127795, 7932.484388514728, 7773.416993725493, 7798.454108212427, 7871.52770833746, 7886.763397098096, 7898.447108702393, 37034.81482592597, 37440.0, 37488.00095992314, 37569.812150939346, 37578.624213758056, 2062.804033616804, 2728.31792051987, 2752.3394385347574, 3076.6923307669276, 3235.4014507316224, 25099.62350564743, 25151.87424062868, 25241.495170096678, 25424.36439089019, 25854.224373268833, 3039.5592639067213, 3050.2526880914097, 3058.0825752274227, 3118.9220269493217, 3159.7472202223767, 149663.0, 150104.249478753, 150210.0, 150695.0, 150784.0, 38763.612363876004, 46184.76907615441, 46276.53723462722, 46403.0, 46431.76784116058, 36710.63289367125, 36850.447243291375, 36922.0, 37017.074573135884, 37116.0, 11716.179867409199, 11900.821487677691, 11930.522779088913, 11934.641960741192, 11959.103067269989, 9075.682351117679, 9210.585523651453, 9222.492762898106, 9229.16937475617, 9243.075692430837, 12663.240205587694, 12839.807402888964, 13214.471421143238, 13226.537071202461, 13341.066125371131, 5965.701714914237, 6049.879002420015, 6080.118382834465, 6104.328523862371, 6104.694765261719, 869.1873098652779, 889.4840992224495, 909.3952521573212, 947.1475671895212, 999.2555546118189, 25979.870100649754, 26114.608280875804, 26210.475790484466, 26446.735532644427, 26473.735262647126, 997.217184510156, 1006.8036732837173, 1034.4569101221919, 1038.2939601071193, 1066.1151244467073, 13470.854977327037, 13582.459599127595, 13692.65768355799, 14077.0, 14080.577582672537, 259129.26965842687, 261137.0, 261689.0, 261706.0, 264490.0, 45398.0, 45861.08277834491, 46033.539664603595, 46055.53944460512, 46148.76925615351, 1161.4599211366756, 1172.2439026827649, 1181.1554738362113, 1186.0748616079472, 1195.8804119587971, 24786.50426991414, 25824.22527324183, 25864.8706756465, 26034.869825650752, 26270.343241419116, 40022.1995560093, 40025.39961900632, 40240.1951960965, 40270.19459610733, 40457.59542404656, 243268.0, 244639.0, 244658.0, 245369.0, 246052.0, 29571.26071848221, 29723.405531889675, 30044.549331759605, 30505.847470762503, 30580.541291881083, 38585.49194302361, 38845.223095538495, 39444.60555394409, 39517.40723889087, 39596.2080758389, 33307.16732081717, 33364.33271334511, 33415.16462088467, 33509.497357540145, 33589.83205084057, 30531.694683052887, 31969.520457193626, 32159.0, 32439.513407299382, 32526.674733252363, 33771.0, 34018.489722654675, 35289.0, 36519.45220821637, 36534.45198321974, 28205.0, 30246.243843903198, 30839.383212336077, 30845.691543084282, 30917.536236956013, 23615.40961475977, 23706.170284039978, 24137.51724965526, 24140.0, 24239.151629692875], "unit": "score", "name": "ext.html", "value": 15766.852560300678}, {"lowerIsBetter": false, "replicates": [323.2597352063773, 331.6716450713793, 336.50533715438297, 339.5500961226375, 341.4690156806167, 14677.70644587109, 15181.696366072672, 15685.686286274267, 15780.447684331051, 15795.289211985459, 14393.06445081069, 14528.564143075699, 14760.0, 14950.028248163862, 15540.533783986499, 4812.783424745886, 4965.7020578765205, 4988.152014157602, 4999.025190087934, 5005.899882002358, 4809.807607695688, 4944.0, 4997.725125118117, 5004.649674522785, 5029.874253143683, 4975.552200301972, 4988.65079444439, 4991.0, 4992.400911890578, 4993.950060499403, 4930.605551555885, 4933.432655244639, 4937.7777999990085, 6147.815565533041, 6344.555881088326, 6045.6674882881425, 6110.450059494667, 6146.323904370515, 6150.66171360575, 6155.0, 20318.79681203184, 21036.684449733268, 21037.78962210389, 21041.47396315089, 21189.364319070453, 1920.9231630734894, 1926.489480287725, 1967.1737870094594, 1968.4389948864648, 2053.815156635895, 12760.617181484571, 13431.731365372638, 13774.586762397144, 13847.653808654764, 14267.500637477742, 1867.4117652939417, 1892.1863598652574, 1901.1141366687618, 1901.3820508334848, 1952.3166891587973, 45702.314465283045, 50604.74697626488, 57038.0, 62751.686241568954, 63915.360846391406, 14757.893158013192, 16165.191740412933, 16189.919050404907, 16287.267072981744, 16398.09810460436, 23304.65043024356, 23317.41706457352, 23580.528389432115, 23665.645015324782, 23705.644415333783, 7868.921310786934, 7922.564258965812, 8072.556009419538, 8125.512469251864, 8157.67369305233, 6633.701483433257, 6724.9327506725285, 6730.427913627396, 6864.24493305736, 6944.02783610295, 7693.307602315818, 7790.688372465038, 7795.961020194863, 7892.763217103496, 7903.486273392211, 3046.5277881928337, 3099.8140111592925, 3143.842807859598, 3167.920801979923, 3297.5383446317533, 835.7492752174323, 842.8019415437367, 906.2659246010752, 914.0083009934162, 938.8357037518407, 15132.0, 15619.0, 15715.214239288218, 15787.842121578637, 16218.270177842025, 868.6959564152622, 884.4074470105045, 894.673444192865, 933.9766505837273, 941.9387739796891, 8710.520921349387, 8922.598483068277, 8952.209558088278, 8988.325875559229, 9082.818343633091, 346319.0, 353017.0, 362078.0, 370200.0, 374265.0, 63681.36318636847, 63781.68109159425, 64208.394790129685, 64268.67865660642, 65119.0, 928.0672923711761, 928.4336554701626, 929.2426672262085, 933.780561568031, 941.5998200764648, 13792.862071379157, 13836.169829810244, 14096.154230746188, 14192.858071419154, 14437.566872993826, 29440.263993400335, 30742.231444214074, 30820.0, 31011.84494077515, 31672.524912125875, 39206.0, 41000.179996400504, 41910.58089419189, 41963.7901810489, 42238.366424504275, 6463.612183269019, 6691.5315927884585, 6728.966355168389, 6782.491313151435, 6837.316268373322, 8880.955595221982, 10102.343347682377, 10127.594896204364, 10683.732906677395, 10694.358338499404, 9498.95250523743, 9504.762380940532, 9506.572204250964, 9548.85676714836, 9727.464989425649, 9123.817523649623, 9497.810043798947, 9644.421334719938, 9733.9026609733, 9792.755181120529, 9594.232461402931, 9637.759056023655, 9656.22750179998, 9803.80392392134, 9927.106560409598, 6919.619420931897, 6965.094537710268, 6968.6864091115, 7011.368976792113, 7184.0, 8669.263112635497, 8728.563571821256, 8742.300615950582, 8874.911250887408, 9809.264305177283], "unit": "score", "name": "jquery.html", "value": 8355.774924067135}, {"lowerIsBetter": false, "replicates": [1338.3575883575884, 1344.5294147048535, 1454.5490897821676, 1702.889312194708, 1722.5693576605856, 5884.411558844114, 6846.212685541164, 6997.685104170312, 7167.390771784398, 7200.747973820918, 6938.9653051734795, 6945.097137372135, 6949.166100067986, 6956.791296261107, 6964.268751781066, 2081.0635214153617, 2083.312506872736, 2105.9368218953377, 2108.620448319302, 2111.028926693715, 1995.281698588507, 2046.3758553641132, 2051.897405129745, 2079.979200208001, 2085.8957052147407, 2029.989850050755, 2033.379819155157, 2033.5322875738589, 2033.613613413454, 2038.2254743197564, 2028.9753674394483, 2035.3283416472602, 2036.5417780999305, 2039.4901274681329, 2043.2439997200981, 1997.1711739628038, 2017.8083082107323, 2072.3057775645175, 2088.540521085374, 2091.9477013074643, 6956.721731130749, 6964.4080253178545, 6993.0908981832545, 7023.0, 7033.824154396129, 4090.509138903321, 4211.410402543646, 4213.5786421357925, 4226.78866056699, 4227.302495088306, 2676.6118912757543, 2767.4188420431733, 2785.387214812738, 2793.1201671473423, 2793.7625301849366, 841.6170642357713, 855.2644725536034, 866.9349798765118, 867.9783005424852, 893.6916763716507, 9383.390079644802, 9433.716988490356, 9469.66856160031, 9488.193503552206, 9543.188828949547, 3826.9234615307537, 3898.746581472252, 3899.6490315871706, 3950.762954222698, 3959.584243654375, 8205.835883282301, 8231.34149268057, 8246.299064579458, 8266.710665126691, 8274.917250827535, 4249.532551419341, 4252.043290259729, 4267.4025636410925, 4269.978650106792, 4274.700770946066, 3156.921076973094, 3710.8330125144435, 3790.3935370340614, 3796.069962859062, 3797.3354662933875, 3259.983700081532, 3324.0194142727955, 3334.9166270843425, 3337.098983274551, 3338.2822693121097, 1074.7420619051372, 1114.7491814341709, 1116.4585176189541, 1118.2675347647305, 1124.0221007723333, 910.0035461170008, 996.7906739584769, 1143.588308209044, 1174.6241202815188, 1175.5532897498895, 6518.348165183444, 6519.8696026079215, 6539.574927629689, 6544.7382104716235, 6567.113439685677, 1042.3172821801732, 1047.3401756893109, 1054.4358768059205, 1085.6091806949491, 1088.7169335972546, 5212.661177023481, 5248.685078895279, 5275.762590683428, 5290.761915713802, 5299.311089558333, 8056.436049476598, 8459.196376344238, 8493.193146651058, 8504.532250726146, 8532.317414606816, 8354.0, 8362.707305244287, 8395.496270223806, 8398.286145677564, 8434.62044208012, 6580.21037475506, 6677.499187560952, 6749.527533072638, 6766.695498702472, 6773.8983915241315, 6389.2971773105855, 6398.296187419473, 6400.423961843457, 6402.199725034371, 6501.642409667514, 7373.410127189704, 7638.732644357421, 7705.383569314554, 7770.300672939463, 7791.142974272939, 7311.524750891175, 7526.435517336331, 7529.058867641545, 7531.774046778605, 7757.495762775401, 5196.818111366084, 5971.58198926071, 5984.760609575568, 6069.423404776539, 6084.969575152096, 6642.90035649456, 6644.0, 6708.161479815023, 6718.361755633207, 6724.630145342053, 5937.910931335947, 6033.095035744674, 6054.485368743706, 6178.783742568989, 6200.534959878118, 5712.65724056558, 5779.768809247751, 5871.354151043296, 6063.878722425438, 6075.2405949256345, 5982.88034239304, 6361.9502782040445, 6466.256380516301, 6490.415862572391, 6504.252011018604, 5984.0, 5987.520998320037, 5989.820305390671, 5999.340072592098, 6001.339852616296, 6012.188354572252, 6018.638881667114, 6038.365971572922, 6053.545984051302, 6146.661933593696], "unit": "score", "name": "mootools.html", "value": 4047.9425089697215}, {"lowerIsBetter": false, "replicates": [285.6900263214412, 297.2598230406289, 301.6094158065305, 303.99088027359176, 306.01768323680983, 5700.800471983476, 5713.45722156395, 5772.018756811347, 5802.0, 5828.9417105828925, 5690.975624387608, 5698.259226300585, 5704.201411802351, 5706.087026075828, 5719.656820590768, 4099.836006559742, 4212.925703945505, 4308.030693094061, 4311.655067594601, 4331.220380331539, 4257.276263035292, 4298.914021719564, 4314.460692413449, 4318.654507639397, 4320.135972805436, 4288.764117973526, 4317.870463886088, 4318.0, 4321.114171594815, 4330.805113769888, 4296.462942132233, 4326.199653064194, 4330.891727706817, 4337.457817772778, 4339.696221264513, 3782.3191825471404, 3790.962090379116, 3793.791341476218, 3796.354619714655, 3799.8480060797533, 5425.131978883399, 5429.321334833146, 5437.34751829783, 5445.646033007882, 5462.945370546323, 4711.717296962193, 4870.7564621769125, 4891.144049791273, 4927.113119638464, 5029.572486338666, 5946.286445626509, 5964.582479226456, 5974.731137098841, 6036.849078773022, 6042.425969532887, 3982.522097348308, 3996.3406038003695, 3998.3402738548107, 4000.8399664013405, 4000.9997500624845, 6238.407351301619, 6265.248170219557, 6307.463865571432, 6322.683865806691, 6328.620282783002, 4075.9810047488127, 4104.651104656137, 4107.691923105779, 4108.91782164361, 4118.19695159447, 4063.39049142631, 4156.168766246763, 4159.625633692982, 4167.5207351154395, 4168.520620128724, 4822.083804077214, 4865.0756356292195, 4869.780859861315, 4877.487863774323, 4881.389826271716, 5964.0, 6011.158437818709, 6020.789272375446, 6024.698765061729, 6025.096235564701, 1454.5999850041112, 1467.523055007127, 1471.5511768910585, 1476.970460590782, 1477.5050358129931, 944.1031020530523, 945.177695405002, 960.8846938367301, 989.618996686281, 990.7374545745383, 5142.30578871855, 5153.175491921274, 5170.793168273227, 5204.73976301191, 5206.869828254324, 6190.133381326618, 6243.906341404882, 6248.0003199487865, 6248.687565621792, 6254.499640028786, 5019.799208031638, 5101.69389836611, 5202.71385073817, 5204.0, 5208.479152084837, 3350.966490335114, 3382.2728113455723, 3394.8132852692843, 3405.744569157323, 3413.6245013048547, 5894.440028197314, 5939.762409503658, 5947.583669143205, 5953.255843019622, 5967.19442875215, 6442.323556026643, 6471.158749362553, 6476.158099447041, 6483.222013358427, 6487.610743355413, 5764.250647415809, 5854.268216472941, 5887.646741195542, 5897.410258974069, 5899.616524925866, 6072.908906366496, 6320.936790632035, 6323.810285691437, 6325.525585581007, 6345.1434056401795, 6181.752729890754, 6190.907136392868, 6193.349698281796, 6233.470155036873, 6247.0, 5847.298324201123, 5921.792737254348, 5927.614705044159, 5937.406259374201, 5940.138679891305, 4030.91938161241, 4039.979800100981, 4073.4704488416314, 4084.5302790179508, 4085.3054980653956, 6090.969545152246, 6171.074338849208, 6239.251289845248, 6301.338359472189, 6301.369863013662, 6020.247469066367, 6030.6080104793045, 6051.727672254671, 6062.909056364247, 6068.120122582289, 6040.939590604214, 6043.848903777265, 6051.425114614281, 6053.485453736482, 6073.605215660968, 5914.881702366015, 5915.40845915405, 5920.082387229986, 5927.436893495111, 5935.169076329404, 5931.584789064724, 6066.848328791815, 6091.269047714302, 6092.055731361646, 6120.632762034292, 5899.705014749331, 5925.318588362394, 5927.792527261525, 5933.792317268875, 5939.4357536034], "unit": "score", "name": "prototype.html", "value": 4443.2955926711}, {"lowerIsBetter": false, "replicates": [564.2608183279904, 564.96327738697, 697.0067653593628, 709.7835160276115, 711.8397012869025, 10581.894181058187, 10830.566777328908, 10894.40080795557, 10897.509612067457, 10991.230613857013, 11218.270812397188, 11237.60668376607, 11242.718932026703, 11246.49390777415, 11267.943660281708, 593.5637306579661, 755.6712829918989, 760.9467337286392, 772.1622040086513, 776.1036003416064, 749.7525816480576, 760.0461420916741, 764.6176911544228, 765.2577000309691, 770.433731207562, 806.5644551941945, 814.0150417994234, 815.2499700275731, 817.4114637461018, 818.6029775558849, 802.4142376065475, 804.9436539442241, 805.0621026504116, 806.3025482957229, 807.9838403231931, 603.7916918663054, 606.3178923710825, 606.5693357716027, 607.6202373516552, 608.5800797449746, 10903.672889813319, 10957.12343012557, 10969.122470202365, 11005.504752286086, 11042.723931901686, 11598.652040438801, 11779.587714429954, 11919.344436056013, 12112.697182570419, 12186.0, 9385.483798391086, 9470.526877910244, 9650.0, 9654.90345096547, 9723.65967191152, 3270.4767237242163, 3296.1924328539662, 3332.750043746729, 3333.2500187457626, 3412.2663627320244, 39998.0, 40120.0, 40129.0, 40309.0, 40456.59543404558, 8776.297896168291, 9127.90872091284, 9163.81672366549, 9193.49435781025, 9200.263978881674, 16445.25996330168, 16512.25694843735, 16579.088150151856, 16622.833771662372, 16639.584010399594, 6245.188125543741, 6328.240611126602, 6425.714857028613, 6442.645654489048, 6493.188351456068, 3641.089727568108, 3658.32321020612, 3691.7046636269033, 3743.9064023399087, 3746.793926334023, 2515.471750932288, 2541.9491610167693, 2548.5030419068103, 2567.537843188244, 2571.6528268683865, 435.5165765999738, 439.25765456378616, 447.8007286757427, 453.81620443720345, 454.33666846404617, 439.65047787009405, 590.8138936235072, 605.2457942858869, 618.811262564913, 656.8620589676126, 7412.258774122544, 7537.472376933562, 7657.617119144021, 7736.381089512825, 8068.878966815502, 584.8654809393863, 587.7854583077146, 597.4082586985809, 606.1029676079427, 621.8134559632092, 3237.8542965566608, 3593.6765691087926, 3670.724695647837, 3693.963060369416, 3743.7192210584317, 49233.26150107751, 49514.0, 49681.50318496769, 49962.750186248835, 50230.49769502258, 47857.521424786006, 47933.52066479291, 48126.27810582844, 49055.509444905096, 49157.50842491529, 40711.79644101761, 40908.59091409107, 40962.79518602447, 41000.38499422511, 41715.79142104331, 7836.294733474015, 8115.350771938349, 8656.523891186045, 8670.046294907681, 8769.868451973352, 31031.689683103785, 31291.374172516877, 31422.0, 31893.20266993344, 32230.19424514406, 36808.44787328139, 37508.624913750515, 38464.0, 39287.41068883912, 39871.80064099661, 9521.57152928106, 9605.519724013911, 9702.078302561245, 9775.85336219943, 9934.552945117632, 9416.529173541432, 9681.757956051155, 10529.315594486334, 10735.731606709895, 10800.189985750943, 9325.906740932503, 9437.57530911097, 9541.427514349161, 9696.17582505495, 10479.0, 8935.693479722264, 9018.549072546215, 9115.726528204164, 9174.128457796498, 10444.216683748597, 10054.949725251327, 10156.238282129018, 10165.542550585093, 10186.137826486683, 10219.335743176669, 8533.445326053787, 8613.26787223093, 8735.737927862174, 8890.39161478933, 9416.905830941603, 8664.220220180214, 8727.389082764146, 9049.366544341832, 9096.727098187064, 9228.815423691354], "unit": "score", "name": "yui.html", "value": 5596.845684848557}], "name": "dromaeo_css", "value": 6262.874173112826}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 115.0, 115.0, 115.0, 126.0, 114.0, 114.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [157.0, 139.0, 159.0, 165.0, 135.0, 154.0, 152.0, 132.0, 183.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [165.0, 166.0, 163.0, 165.0, 164.0, 170.0, 165.0, 163.0, 167.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.1}, {"lowerIsBetter": true, "replicates": [78.0, 74.0, 73.0, 74.0, 79.0, 147.0, 74.0, 73.0, 73.0, 75.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 141.0, 98.0, 99.0, 98.0, 148.0, 98.0, 97.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 117.0, 117.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.1}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 150.0, 148.0, 149.0, 148.0, 149.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 97.0, 97.0, 98.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 67.0, 68.0, 68.0, 74.0, 67.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 71.0, 72.0, 71.0, 71.0, 78.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.8}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 91.0, 84.0, 87.0, 86.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 125.0, 134.0, 136.0, 135.0, 123.0, 124.0, 125.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [146.0, 164.0, 145.0, 150.0, 152.0, 139.0, 153.0, 149.0, 151.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 74.0, 75.0, 70.0, 71.0, 72.0, 71.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1560.8000000000002}]} 09:27:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1560.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6262.87"}}} 09:27:51 INFO - Return code: 0 09:27:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:27:51 ERROR - # TBPL SUCCESS # 09:27:51 INFO - Running post-action listener: _resource_record_post_action 09:27:51 INFO - Running post-run listener: _resource_record_post_run 09:27:52 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525864960; Read time: 12; Write time: 342876 09:27:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233299968; Read time: 0; Write time: 161176 09:27:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292306944; Read time: 12; Write time: 181676 09:27:52 INFO - Running post-run listener: _upload_blobber_files 09:27:52 INFO - Blob upload gear active. 09:27:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:27:52 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 09:27:52 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'] 09:27:52 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 09:27:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:27:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:54 INFO - (blobuploader) - INFO - Done attempting. 09:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:27:55 INFO - (blobuploader) - INFO - Done attempting. 09:27:55 INFO - (blobuploader) - INFO - Iteration through files over. 09:27:55 INFO - Return code: 0 09:27:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:27:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:27:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf2a9ee0427df253cb7f5595d102e507fd8af318201d994910e6e0edb547f99c73af9dbbde0d8f22827613471a235ae0f19d6bb3ea028e54cea97d9c91d73fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea61faac9cb56bb349ade4de641f876513ebfde0782d3c772a3b1538d266be7989ea6d0118f98748b72c52379ead5d3b35789f16c999848d085d14b8f53a12fe"} 09:27:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:27:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:27:55 INFO - Contents: 09:27:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf2a9ee0427df253cb7f5595d102e507fd8af318201d994910e6e0edb547f99c73af9dbbde0d8f22827613471a235ae0f19d6bb3ea028e54cea97d9c91d73fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea61faac9cb56bb349ade4de641f876513ebfde0782d3c772a3b1538d266be7989ea6d0118f98748b72c52379ead5d3b35789f16c999848d085d14b8f53a12fe"} 09:27:55 INFO - Running post-run listener: copy_logs_to_upload_dir 09:27:55 INFO - Copying logs to upload dir... 09:27:55 INFO - mkdir: /builds/slave/test/build/upload/logs 09:27:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.282886 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-02-29 09:27:54.640033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 09:27:54.643360) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf2a9ee0427df253cb7f5595d102e507fd8af318201d994910e6e0edb547f99c73af9dbbde0d8f22827613471a235ae0f19d6bb3ea028e54cea97d9c91d73fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea61faac9cb56bb349ade4de641f876513ebfde0782d3c772a3b1538d266be7989ea6d0118f98748b72c52379ead5d3b35789f16c999848d085d14b8f53a12fe"} build_url:https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/Mn2rfVRMT3m2MXe_FW6nhA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cf2a9ee0427df253cb7f5595d102e507fd8af318201d994910e6e0edb547f99c73af9dbbde0d8f22827613471a235ae0f19d6bb3ea028e54cea97d9c91d73fba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea61faac9cb56bb349ade4de641f876513ebfde0782d3c772a3b1538d266be7989ea6d0118f98748b72c52379ead5d3b35789f16c999848d085d14b8f53a12fe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 09:27:54.672056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:27:54.672745) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456764313.757600-291283621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 09:27:54.757085) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 09:27:54.757881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 09:27:54.758508) ========= ========= Total master_lag: 0.30 =========