builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1456853944.14 results: success (0) buildid: 20160301085622 builduid: 8390917fe477410895e060cdc102dfb3 revision: 47eb779302fa63ada9a1f7e10c0107ea0b08a9bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.137223) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.137968) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.138302) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004332 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.187597) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.187934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.238983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.239365) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016343 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.291545) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.291864) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.292230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.292537) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 09:39:04-- 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% 214M=0s 2016-03-01 09:39:04 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.228572 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.535659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.536008) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.152291 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.697238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:04.697636) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47eb779302fa63ada9a1f7e10c0107ea0b08a9bd --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 47eb779302fa63ada9a1f7e10c0107ea0b08a9bd --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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 09:39:04,722 truncating revision to first 12 chars 2016-03-01 09:39:04,723 Setting DEBUG logging. 2016-03-01 09:39:04,723 attempt 1/10 2016-03-01 09:39:04,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47eb779302fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 09:39:04,997 unpacking tar archive at: fx-team-47eb779302fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565740 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:05.274955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:05.275336) ========= echo 47eb779302fa63ada9a1f7e10c0107ea0b08a9bd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'47eb779302fa63ada9a1f7e10c0107ea0b08a9bd'] 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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 47eb779302fa63ada9a1f7e10c0107ea0b08a9bd program finished with exit code 0 elapsedTime=0.004702 script_repo_revision: '47eb779302fa63ada9a1f7e10c0107ea0b08a9bd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:05.330861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:05.331219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 09:39:05.346335) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-01 09:39:05.346680) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:39:05 INFO - MultiFileLogger online at 20160301 09:39:05 in /builds/slave/test 09:39:05 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:39:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:05 INFO - {'append_to_log': False, 09:39:05 INFO - 'base_work_dir': '/builds/slave/test', 09:39:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:39:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:05 INFO - 'branch': 'Fx-Team-Non-PGO', 09:39:05 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:05 INFO - 'config_files': ('talos/linux_config.py',), 09:39:05 INFO - 'default_actions': ('clobber', 09:39:05 INFO - 'read-buildbot-config', 09:39:05 INFO - 'download-and-extract', 09:39:05 INFO - 'populate-webroot', 09:39:05 INFO - 'create-virtualenv', 09:39:05 INFO - 'install', 09:39:05 INFO - 'run-tests'), 09:39:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:05 INFO - 'download_minidump_stackwalk': True, 09:39:05 INFO - 'download_symbols': 'ondemand', 09:39:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:05 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:05 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:05 INFO - 'installer_path': 'installer.exe', 09:39:05 INFO - 'log_level': 'info', 09:39:05 INFO - 'log_name': 'talos', 09:39:05 INFO - 'log_to_console': True, 09:39:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:39:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:39:05 INFO - 'opt_config_files': (), 09:39:05 INFO - 'pip_index': False, 09:39:05 INFO - 'sps_profile': False, 09:39:05 INFO - 'sps_profile_interval': 0, 09:39:05 INFO - 'suite': 'dromaeojs-e10s', 09:39:05 INFO - 'system_bits': '32', 09:39:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:05 INFO - 'title': 'talos-linux64-ix-067', 09:39:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:05 INFO - 'use_talos_json': True, 09:39:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:05 INFO - 'work_dir': 'build'} 09:39:05 INFO - ##### 09:39:05 INFO - ##### Running clobber step. 09:39:05 INFO - ##### 09:39:05 INFO - Running pre-action listener: _resource_record_pre_action 09:39:05 INFO - Running main action method: clobber 09:39:05 INFO - rmtree: /builds/slave/test/build 09:39:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:07 INFO - Running post-action listener: _resource_record_post_action 09:39:07 INFO - ##### 09:39:07 INFO - ##### Running read-buildbot-config step. 09:39:07 INFO - ##### 09:39:07 INFO - Running pre-action listener: _resource_record_pre_action 09:39:07 INFO - Running main action method: read_buildbot_config 09:39:07 INFO - Using buildbot properties: 09:39:07 INFO - { 09:39:07 INFO - "project": "", 09:39:07 INFO - "product": "firefox", 09:39:07 INFO - "script_repo_revision": "production", 09:39:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:39:07 INFO - "repository": "", 09:39:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:39:07 INFO - "buildid": "20160301085622", 09:39:07 INFO - "pgo_build": "False", 09:39:07 INFO - "basedir": "/builds/slave/test", 09:39:07 INFO - "buildnumber": 1179, 09:39:07 INFO - "slavename": "talos-linux64-ix-067", 09:39:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:39:07 INFO - "platform": "ubuntu64_hw", 09:39:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:39:07 INFO - "branch": "fx-team", 09:39:07 INFO - "repo_path": "integration/fx-team", 09:39:07 INFO - "revision": "47eb779302fa63ada9a1f7e10c0107ea0b08a9bd", 09:39:07 INFO - "stage_platform": "linux64", 09:39:07 INFO - "builduid": "8390917fe477410895e060cdc102dfb3", 09:39:07 INFO - "slavebuilddir": "test" 09:39:07 INFO - } 09:39:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:39:07 INFO - Running post-action listener: _resource_record_post_action 09:39:07 INFO - ##### 09:39:07 INFO - ##### Running download-and-extract step. 09:39:07 INFO - ##### 09:39:07 INFO - Running pre-action listener: _resource_record_pre_action 09:39:07 INFO - Running main action method: download_and_extract 09:39:07 INFO - mkdir: /builds/slave/test/build/tests 09:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:07 INFO - https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:39:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:39:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:39:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:39:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:39:08 INFO - Downloaded 1448 bytes. 09:39:08 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 09:39:08 INFO - Using the following test package requirements: 09:39:08 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:39:08 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:39:08 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:39:08 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:08 INFO - u'jsshell-linux-x86_64.zip'], 09:39:08 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:39:08 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:39:08 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:39:08 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:39:08 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:39:08 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:39:08 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:39:08 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:39:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:08 INFO - https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:39:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:39:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:39:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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:39:09 INFO - Downloaded 22077569 bytes. 09:39:09 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:39:09 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:39:11 INFO - Return code: 0 09:39:11 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:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:11 INFO - https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:39:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:39:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:39:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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:39:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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:39:12 INFO - Downloaded 22077569 bytes. 09:39:12 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:39:12 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:39:13 INFO - Return code: 0 09:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:13 INFO - https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:39:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:39:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:39:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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:39:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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:39:15 INFO - Downloaded 10713413 bytes. 09:39:15 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:39:15 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:39:15 INFO - Return code: 0 09:39: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:39:15 INFO - https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:39:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:39:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:39:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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:39:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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:39:17 INFO - Downloaded 54387784 bytes. 09:39:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:39:17 INFO - mkdir: /builds/slave/test/properties 09:39:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:17 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:17 INFO - Contents: 09:39:17 INFO - build_url:https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:39:18 INFO - Running post-action listener: _resource_record_post_action 09:39:18 INFO - Running post-action listener: set_extra_try_arguments 09:39:18 INFO - ##### 09:39:18 INFO - ##### Running populate-webroot step. 09:39:18 INFO - ##### 09:39:18 INFO - Running pre-action listener: _resource_record_pre_action 09:39:18 INFO - Running main action method: populate_webroot 09:39:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:18 INFO - '--tppagecycles', 09:39:18 INFO - '7'], 09:39:18 INFO - 'tests': ['tsvgm']}}, 09:39:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:39:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:39:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:18 INFO - 'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:18 INFO - 'tests': ['damp', 'tps']}, 09:39:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:18 INFO - 'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['damp', 'tps']}, 09:39:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:39:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:18 INFO - 'other': {'tests': ['a11yr', 09:39:18 INFO - 'ts_paint', 09:39:18 INFO - 'tpaint', 09:39:18 INFO - 'sessionrestore', 09:39:18 INFO - 'sessionrestore_no_auto_restore']}, 09:39:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['a11yr', 09:39:18 INFO - 'ts_paint', 09:39:18 INFO - 'tpaint', 09:39:18 INFO - 'sessionrestore', 09:39:18 INFO - 'sessionrestore_no_auto_restore']}, 09:39:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['a11yr', 09:39:18 INFO - 'ts_paint', 09:39:18 INFO - 'tpaint', 09:39:18 INFO - 'sessionrestore', 09:39:18 INFO - 'sessionrestore_no_auto_restore']}, 09:39:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['a11yr', 09:39:18 INFO - 'ts_paint', 09:39:18 INFO - 'tpaint', 09:39:18 INFO - 'sessionrestore', 09:39:18 INFO - 'sessionrestore_no_auto_restore']}, 09:39:18 INFO - 'other_l64': {'tests': ['a11yr', 09:39:18 INFO - 'ts_paint', 09:39:18 INFO - 'tpaint', 09:39:18 INFO - 'sessionrestore', 09:39:18 INFO - 'sessionrestore_no_auto_restore']}, 09:39:18 INFO - 'other_nol64': {'tests': ['a11yr', 09:39:18 INFO - 'ts_paint', 09:39:18 INFO - 'tpaint', 09:39:18 INFO - 'sessionrestore', 09:39:18 INFO - 'sessionrestore_no_auto_restore']}, 09:39:18 INFO - 'svgr': {'tests': ['tsvgx', 09:39:18 INFO - 'tsvgr_opacity', 09:39:18 INFO - 'tart', 09:39:18 INFO - 'tscrollx', 09:39:18 INFO - 'cart']}, 09:39:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['tsvgx', 09:39:18 INFO - 'tsvgr_opacity', 09:39:18 INFO - 'tart', 09:39:18 INFO - 'tscrollx', 09:39:18 INFO - 'cart']}, 09:39:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:18 INFO - 'tests': ['tp5o']}, 09:39:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:18 INFO - 'talos_options': ['--e10s'], 09:39:18 INFO - 'tests': ['tp5o']}, 09:39:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:18 INFO - 'talos_options': ['--xperf_path', 09:39:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:18 INFO - 'tests': ['tp5n']}, 09:39:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:39:18 INFO - 'talos_options': ['--e10s', 09:39:18 INFO - '--xperf_path', 09:39:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:18 INFO - 'tests': ['tp5n']}}, 09:39:18 INFO - 'talos.zip': {'path': '', 09:39:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:18 INFO - Running post-action listener: _resource_record_post_action 09:39:18 INFO - ##### 09:39:18 INFO - ##### Running create-virtualenv step. 09:39:18 INFO - ##### 09:39:18 INFO - Running pre-action listener: _resource_record_pre_action 09:39:18 INFO - Running main action method: create_virtualenv 09:39:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:18 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:39:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:18 INFO - Using real prefix '/usr' 09:39:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:21 INFO - Installing pip.................done. 09:39:21 INFO - Return code: 0 09:39:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39:21 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:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:21 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:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:21 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 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39:21 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:39:21 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:39:21 INFO - Using env: {'DISPLAY': ':0', 09:39:21 INFO - 'HOME': '/home/cltbld', 09:39:21 INFO - 'LANG': 'en_US.UTF-8', 09:39:21 INFO - 'LANGUAGE': 'en_US:en', 09:39:21 INFO - 'LOGNAME': 'cltbld', 09:39:21 INFO - 'MAIL': '/var/mail/cltbld', 09:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:21 INFO - 'MOZ_NO_REMOTE': '1', 09:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:21 INFO - 'NO_EM_RESTART': '1', 09:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:21 INFO - 'PWD': '/builds/slave/test', 09:39:21 INFO - 'SHELL': '/bin/bash', 09:39:21 INFO - 'SHLVL': '1', 09:39:21 INFO - 'TERM': 'linux', 09:39:21 INFO - 'TMOUT': '86400', 09:39:21 INFO - 'USER': 'cltbld', 09:39:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:21 INFO - '_': '/tools/buildbot/bin/python'} 09:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:22 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:39:22 INFO - Cleaning up... 09:39:22 INFO - Return code: 0 09:39:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:39:22 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:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:22 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:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:22 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 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39:22 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:39:22 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:39:22 INFO - Using env: {'DISPLAY': ':0', 09:39:22 INFO - 'HOME': '/home/cltbld', 09:39:22 INFO - 'LANG': 'en_US.UTF-8', 09:39:22 INFO - 'LANGUAGE': 'en_US:en', 09:39:22 INFO - 'LOGNAME': 'cltbld', 09:39:22 INFO - 'MAIL': '/var/mail/cltbld', 09:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:22 INFO - 'MOZ_NO_REMOTE': '1', 09:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:22 INFO - 'NO_EM_RESTART': '1', 09:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:22 INFO - 'PWD': '/builds/slave/test', 09:39:22 INFO - 'SHELL': '/bin/bash', 09:39:22 INFO - 'SHLVL': '1', 09:39:22 INFO - 'TERM': 'linux', 09:39:22 INFO - 'TMOUT': '86400', 09:39:22 INFO - 'USER': 'cltbld', 09:39:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:22 INFO - '_': '/tools/buildbot/bin/python'} 09:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:22 INFO - Downloading/unpacking psutil>=0.7.1 09:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:24 INFO - Installing collected packages: psutil 09:39:24 INFO - Running setup.py install for psutil 09:39:24 INFO - building 'psutil._psutil_linux' extension 09:39:24 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:39:25 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:39:25 INFO - building 'psutil._psutil_posix' extension 09:39:25 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:39:25 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:39:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:25 INFO - Successfully installed psutil 09:39:25 INFO - Cleaning up... 09:39:25 INFO - Return code: 0 09:39:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:39:25 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:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:25 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:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:25 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 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39:25 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:39:25 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:39:25 INFO - Using env: {'DISPLAY': ':0', 09:39:25 INFO - 'HOME': '/home/cltbld', 09:39:25 INFO - 'LANG': 'en_US.UTF-8', 09:39:25 INFO - 'LANGUAGE': 'en_US:en', 09:39:25 INFO - 'LOGNAME': 'cltbld', 09:39:25 INFO - 'MAIL': '/var/mail/cltbld', 09:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:25 INFO - 'MOZ_NO_REMOTE': '1', 09:39:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:25 INFO - 'NO_EM_RESTART': '1', 09:39:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:25 INFO - 'PWD': '/builds/slave/test', 09:39:25 INFO - 'SHELL': '/bin/bash', 09:39:25 INFO - 'SHLVL': '1', 09:39:25 INFO - 'TERM': 'linux', 09:39:25 INFO - 'TMOUT': '86400', 09:39:25 INFO - 'USER': 'cltbld', 09:39:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:25 INFO - '_': '/tools/buildbot/bin/python'} 09:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:39:25 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:39:25 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:39:25 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:39:25 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:39:25 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:39:25 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:39:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:27 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:39:27 INFO - Installing collected packages: mozsystemmonitor 09:39:27 INFO - Running setup.py install for mozsystemmonitor 09:39:27 INFO - Successfully installed mozsystemmonitor 09:39:27 INFO - Cleaning up... 09:39:27 INFO - Return code: 0 09:39:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39:27 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:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:27 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:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:27 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 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39:27 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:39:27 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:39:28 INFO - Using env: {'DISPLAY': ':0', 09:39:28 INFO - 'HOME': '/home/cltbld', 09:39:28 INFO - 'LANG': 'en_US.UTF-8', 09:39:28 INFO - 'LANGUAGE': 'en_US:en', 09:39:28 INFO - 'LOGNAME': 'cltbld', 09:39:28 INFO - 'MAIL': '/var/mail/cltbld', 09:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:28 INFO - 'MOZ_NO_REMOTE': '1', 09:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:28 INFO - 'NO_EM_RESTART': '1', 09:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:28 INFO - 'PWD': '/builds/slave/test', 09:39:28 INFO - 'SHELL': '/bin/bash', 09:39:28 INFO - 'SHLVL': '1', 09:39:28 INFO - 'TERM': 'linux', 09:39:28 INFO - 'TMOUT': '86400', 09:39:28 INFO - 'USER': 'cltbld', 09:39:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:28 INFO - '_': '/tools/buildbot/bin/python'} 09:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:28 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:39:28 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:39:28 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:39:28 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:39:28 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:39:28 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:39:29 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:30 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:39:30 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:39:30 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:39:30 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:39:30 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:39:30 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:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:30 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:39:30 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:39:30 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:39:30 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:39:30 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:39:30 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:39:30 INFO - Downloading docopt-0.6.1.tar.gz 09:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:30 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:30 INFO - Running setup.py install for blobuploader 09:39:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:30 INFO - Running setup.py install for requests 09:39:31 INFO - Running setup.py install for docopt 09:39:31 INFO - Successfully installed blobuploader requests docopt 09:39:31 INFO - Cleaning up... 09:39:31 INFO - Return code: 0 09:39:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:31 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:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:31 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:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:31 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 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39:31 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:39:31 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:39:31 INFO - Using env: {'DISPLAY': ':0', 09:39:31 INFO - 'HOME': '/home/cltbld', 09:39:31 INFO - 'LANG': 'en_US.UTF-8', 09:39:31 INFO - 'LANGUAGE': 'en_US:en', 09:39:31 INFO - 'LOGNAME': 'cltbld', 09:39:31 INFO - 'MAIL': '/var/mail/cltbld', 09:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:31 INFO - 'MOZ_NO_REMOTE': '1', 09:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:31 INFO - 'NO_EM_RESTART': '1', 09:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:31 INFO - 'PWD': '/builds/slave/test', 09:39:31 INFO - 'SHELL': '/bin/bash', 09:39:31 INFO - 'SHLVL': '1', 09:39:31 INFO - 'TERM': 'linux', 09:39:31 INFO - 'TMOUT': '86400', 09:39:31 INFO - 'USER': 'cltbld', 09:39:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:31 INFO - '_': '/tools/buildbot/bin/python'} 09:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:31 INFO - Running setup.py (path:/tmp/pip-d0AWee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:31 INFO - Running setup.py (path:/tmp/pip-lcpD5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:31 INFO - Running setup.py (path:/tmp/pip-Abpws7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:31 INFO - Running setup.py (path:/tmp/pip-jO6F0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:31 INFO - Running setup.py (path:/tmp/pip-_Vv8js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:31 INFO - Running setup.py (path:/tmp/pip-aWpShf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:31 INFO - Running setup.py (path:/tmp/pip-0nFL8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:32 INFO - Running setup.py (path:/tmp/pip-vcaAeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:32 INFO - Running setup.py (path:/tmp/pip-D7qHZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:32 INFO - Running setup.py (path:/tmp/pip-sEge85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:32 INFO - Running setup.py (path:/tmp/pip-xtvSbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:32 INFO - Running setup.py (path:/tmp/pip-BfFc_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:32 INFO - Running setup.py (path:/tmp/pip-WV9neh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:32 INFO - Running setup.py (path:/tmp/pip-YBjgfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:32 INFO - Running setup.py (path:/tmp/pip-jqPvfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:32 INFO - Running setup.py (path:/tmp/pip-rhKCaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:32 INFO - Running setup.py (path:/tmp/pip-lgYKDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:32 INFO - Running setup.py install for manifestparser 09:39:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:32 INFO - Running setup.py install for mozcrash 09:39:32 INFO - Running setup.py install for mozdebug 09:39:33 INFO - Running setup.py install for mozdevice 09:39:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Running setup.py install for mozfile 09:39:33 INFO - Running setup.py install for mozhttpd 09:39:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Running setup.py install for mozinfo 09:39:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Running setup.py install for mozInstall 09:39:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Running setup.py install for mozleak 09:39:33 INFO - Running setup.py install for mozlog 09:39:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Running setup.py install for moznetwork 09:39:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:33 INFO - Running setup.py install for mozprocess 09:39:33 INFO - Running setup.py install for mozprofile 09:39:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:34 INFO - Running setup.py install for mozrunner 09:39:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:34 INFO - Running setup.py install for mozscreenshot 09:39:34 INFO - Running setup.py install for moztest 09:39:34 INFO - Running setup.py install for mozversion 09:39:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:34 INFO - Cleaning up... 09:39:34 INFO - Return code: 0 09:39:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:34 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:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:34 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:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:34 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 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39:34 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:39:34 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:39:34 INFO - Using env: {'DISPLAY': ':0', 09:39:34 INFO - 'HOME': '/home/cltbld', 09:39:34 INFO - 'LANG': 'en_US.UTF-8', 09:39:34 INFO - 'LANGUAGE': 'en_US:en', 09:39:34 INFO - 'LOGNAME': 'cltbld', 09:39:34 INFO - 'MAIL': '/var/mail/cltbld', 09:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:34 INFO - 'MOZ_NO_REMOTE': '1', 09:39:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:34 INFO - 'NO_EM_RESTART': '1', 09:39:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:34 INFO - 'PWD': '/builds/slave/test', 09:39:34 INFO - 'SHELL': '/bin/bash', 09:39:34 INFO - 'SHLVL': '1', 09:39:34 INFO - 'TERM': 'linux', 09:39:34 INFO - 'TMOUT': '86400', 09:39:34 INFO - 'USER': 'cltbld', 09:39:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:34 INFO - '_': '/tools/buildbot/bin/python'} 09:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:34 INFO - Running setup.py (path:/tmp/pip-IU_1Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:34 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:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:34 INFO - Running setup.py (path:/tmp/pip-ve4nkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:34 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:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:34 INFO - Running setup.py (path:/tmp/pip-09aQlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:34 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:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:34 INFO - Running setup.py (path:/tmp/pip-WyH2Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:35 INFO - Running setup.py (path:/tmp/pip-t2ksP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:35 INFO - Running setup.py (path:/tmp/pip-LIACZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:35 INFO - Running setup.py (path:/tmp/pip-thT2mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:35 INFO - Running setup.py (path:/tmp/pip-Hzs3WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:35 INFO - Running setup.py (path:/tmp/pip-i277hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:35 INFO - Running setup.py (path:/tmp/pip-jdPBni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:35 INFO - Running setup.py (path:/tmp/pip-M5fuw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:35 INFO - Running setup.py (path:/tmp/pip-Kzw6h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:35 INFO - Running setup.py (path:/tmp/pip-2Mag_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:35 INFO - Running setup.py (path:/tmp/pip-2YoZl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:35 INFO - Running setup.py (path:/tmp/pip-E0Ip6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:35 INFO - Running setup.py (path:/tmp/pip-iT7RXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:35 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:39:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:35 INFO - Running setup.py (path:/tmp/pip-p9_YqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:35 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:39:35 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:39:35 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:39:35 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:39:35 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:39:35 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:39:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39: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:39: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:39: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:39: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:39: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:39: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:39:37 INFO - Downloading blessings-1.6.tar.gz 09:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:39:37 INFO - Installing collected packages: blessings 09:39:37 INFO - Running setup.py install for blessings 09:39:38 INFO - Successfully installed blessings 09:39:38 INFO - Cleaning up... 09:39:38 INFO - Return code: 0 09:39:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:38 INFO - Reading from file tmpfile_stdout 09:39:38 INFO - Current package versions: 09:39:38 INFO - argparse == 1.2.1 09:39:38 INFO - blessings == 1.6 09:39:38 INFO - blobuploader == 1.2.4 09:39:38 INFO - docopt == 0.6.1 09:39:38 INFO - manifestparser == 1.1 09:39:38 INFO - mozInstall == 1.12 09:39:38 INFO - mozcrash == 0.16 09:39:38 INFO - mozdebug == 0.1 09:39:38 INFO - mozdevice == 0.48 09:39:38 INFO - mozfile == 1.2 09:39:38 INFO - mozhttpd == 0.7 09:39:38 INFO - mozinfo == 0.9 09:39:38 INFO - mozleak == 0.1 09:39:38 INFO - mozlog == 3.1 09:39:38 INFO - moznetwork == 0.27 09:39:38 INFO - mozprocess == 0.22 09:39:38 INFO - mozprofile == 0.28 09:39:38 INFO - mozrunner == 6.11 09:39:38 INFO - mozscreenshot == 0.1 09:39:38 INFO - mozsystemmonitor == 0.0 09:39:38 INFO - moztest == 0.7 09:39:38 INFO - mozversion == 1.4 09:39:38 INFO - psutil == 3.1.1 09:39:38 INFO - requests == 1.2.3 09:39:38 INFO - wsgiref == 0.1.2 09:39:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39: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:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:38 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 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39:38 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:39:38 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:39:38 INFO - Using env: {'DISPLAY': ':0', 09:39:38 INFO - 'HOME': '/home/cltbld', 09:39:38 INFO - 'LANG': 'en_US.UTF-8', 09:39:38 INFO - 'LANGUAGE': 'en_US:en', 09:39:38 INFO - 'LOGNAME': 'cltbld', 09:39:38 INFO - 'MAIL': '/var/mail/cltbld', 09:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:38 INFO - 'MOZ_NO_REMOTE': '1', 09:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:38 INFO - 'NO_EM_RESTART': '1', 09:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:38 INFO - 'PWD': '/builds/slave/test', 09:39:38 INFO - 'SHELL': '/bin/bash', 09:39:38 INFO - 'SHLVL': '1', 09:39:38 INFO - 'TERM': 'linux', 09:39:38 INFO - 'TMOUT': '86400', 09:39:38 INFO - 'USER': 'cltbld', 09:39:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:38 INFO - '_': '/tools/buildbot/bin/python'} 09:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 INFO - Cleaning up... 09:39:38 INFO - Return code: 0 09:39:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:39: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:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39: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', 'jsonschema'] in /builds/slave/test/build 09:39: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 jsonschema 09:39:38 INFO - Using env: {'DISPLAY': ':0', 09:39:38 INFO - 'HOME': '/home/cltbld', 09:39:38 INFO - 'LANG': 'en_US.UTF-8', 09:39:38 INFO - 'LANGUAGE': 'en_US:en', 09:39:38 INFO - 'LOGNAME': 'cltbld', 09:39:38 INFO - 'MAIL': '/var/mail/cltbld', 09:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:38 INFO - 'MOZ_NO_REMOTE': '1', 09:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:38 INFO - 'NO_EM_RESTART': '1', 09:39:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:38 INFO - 'PWD': '/builds/slave/test', 09:39:38 INFO - 'SHELL': '/bin/bash', 09:39:38 INFO - 'SHLVL': '1', 09:39:38 INFO - 'TERM': 'linux', 09:39:38 INFO - 'TMOUT': '86400', 09:39:38 INFO - 'USER': 'cltbld', 09:39:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:38 INFO - '_': '/tools/buildbot/bin/python'} 09:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:38 INFO - Downloading/unpacking jsonschema 09:39: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:39: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:39: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:39: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:39: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:39: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:39:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:40 INFO - Downloading/unpacking functools32 (from jsonschema) 09:39: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:39: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:39: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:39: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:39: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:39: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:39:40 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:40 INFO - warning: no files found matching '*.txt' 09:39:40 INFO - no previously-included directories found matching 'build' 09:39:40 INFO - no previously-included directories found matching 'dist' 09:39:40 INFO - no previously-included directories found matching '.git*' 09:39:40 INFO - Installing collected packages: jsonschema, functools32 09:39:41 INFO - Running setup.py install for functools32 09:39:41 INFO - warning: no files found matching '*.txt' 09:39:41 INFO - no previously-included directories found matching 'build' 09:39:41 INFO - no previously-included directories found matching 'dist' 09:39:41 INFO - no previously-included directories found matching '.git*' 09:39:41 INFO - Successfully installed jsonschema functools32 09:39:41 INFO - Cleaning up... 09:39:41 INFO - Return code: 0 09:39:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:41 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 0x7f650684af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x111b3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', '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:39:41 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:39:41 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:39:41 INFO - Using env: {'DISPLAY': ':0', 09:39:41 INFO - 'HOME': '/home/cltbld', 09:39:41 INFO - 'LANG': 'en_US.UTF-8', 09:39:41 INFO - 'LANGUAGE': 'en_US:en', 09:39:41 INFO - 'LOGNAME': 'cltbld', 09:39:41 INFO - 'MAIL': '/var/mail/cltbld', 09:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:41 INFO - 'MOZ_NO_REMOTE': '1', 09:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:41 INFO - 'NO_EM_RESTART': '1', 09:39:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:41 INFO - 'PWD': '/builds/slave/test', 09:39:41 INFO - 'SHELL': '/bin/bash', 09:39:41 INFO - 'SHLVL': '1', 09:39:41 INFO - 'TERM': 'linux', 09:39:41 INFO - 'TMOUT': '86400', 09:39:41 INFO - 'USER': 'cltbld', 09:39:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:41 INFO - '_': '/tools/buildbot/bin/python'} 09:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:41 INFO - Downloading/unpacking flake8 09:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:39:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:39: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:39: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:39: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:39: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:39: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:39: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:39:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:39:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:39: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:39: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:39: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:39: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:39: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:39: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:39:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:39: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:39: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:39: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:39: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:39: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:39: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:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:39:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:43 INFO - no previously-included directories found matching 'docs/_build' 09:39:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:39:44 INFO - Running setup.py install for pep8 09:39:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:44 INFO - no previously-included directories found matching 'docs/_build' 09:39:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:39:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:39:44 INFO - Cleaning up... 09:39:44 INFO - Return code: 0 09:39:44 INFO - Running post-action listener: _resource_record_post_action 09:39:44 INFO - Running post-action listener: _start_resource_monitoring 09:39:44 INFO - Starting resource monitoring. 09:39:44 INFO - ##### 09:39:44 INFO - ##### Running install step. 09:39:44 INFO - ##### 09:39:44 INFO - Running pre-action listener: _resource_record_pre_action 09:39:44 INFO - Running main action method: install 09:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:44 INFO - Reading from file tmpfile_stdout 09:39:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:44 INFO - Reading from file tmpfile_stdout 09:39:44 INFO - Output received: 09:39:44 INFO - Usage: mozinstall [options] installer 09:39:44 INFO - Options: 09:39:44 INFO - -h, --help show this help message and exit 09:39:44 INFO - -d DEST, --destination=DEST 09:39:44 INFO - Directory to install application into. [default: 09:39:44 INFO - "/builds/slave/test"] 09:39:44 INFO - --app=APP Application being installed. [default: firefox] 09:39:44 INFO - mkdir: /builds/slave/test/build/application 09:39:44 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:39:44 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:40:00 INFO - Reading from file tmpfile_stdout 09:40:00 INFO - Output received: 09:40:00 INFO - /builds/slave/test/build/application/firefox/firefox 09:40:00 INFO - Running post-action listener: _resource_record_post_action 09:40:00 INFO - ##### 09:40:00 INFO - ##### Running run-tests step. 09:40:00 INFO - ##### 09:40:00 INFO - Running pre-action listener: _resource_record_pre_action 09:40:00 INFO - Running main action method: run_tests 09:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:00 INFO - Python 2.7.3 09:40:00 INFO - Return code: 0 09:40:00 INFO - grabbing minidump binary from tooltool 09:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:40:00 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 0x11aa100>, '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 0x11ab000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ab490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:00 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:40:00 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:40:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:00 INFO - Return code: 0 09:40:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:40:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:40:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:40:01 INFO - Return code: 0 09:40:01 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/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:40:01 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/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:40:01 INFO - Using env: {'DISPLAY': ':0', 09:40:01 INFO - 'HOME': '/home/cltbld', 09:40:01 INFO - 'LANG': 'en_US.UTF-8', 09:40:01 INFO - 'LANGUAGE': 'en_US:en', 09:40:01 INFO - 'LOGNAME': 'cltbld', 09:40:01 INFO - 'MAIL': '/var/mail/cltbld', 09:40:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:01 INFO - 'MOZ_NO_REMOTE': '1', 09:40:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:01 INFO - 'NO_EM_RESTART': '1', 09:40:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:01 INFO - 'PWD': '/builds/slave/test', 09:40:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:01 INFO - 'SHELL': '/bin/bash', 09:40:01 INFO - 'SHLVL': '1', 09:40:01 INFO - 'TERM': 'linux', 09:40:01 INFO - 'TMOUT': '86400', 09:40:01 INFO - 'USER': 'cltbld', 09:40:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027', 09:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:01 INFO - '_': '/tools/buildbot/bin/python'} 09:40:01 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/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:40:01 INFO - mozversion application_buildid: 20160301085622 09:40:01 INFO - mozversion application_changeset: 47eb779302fa63ada9a1f7e10c0107ea0b08a9bd 09:40:01 INFO - mozversion application_display_name: Nightly 09:40:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:01 INFO - mozversion application_name: Firefox 09:40:01 INFO - mozversion application_remotingname: firefox 09:40:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:40:01 INFO - mozversion application_vendor: Mozilla 09:40:01 INFO - mozversion application_version: 47.0a1 09:40:01 INFO - mozversion platform_buildid: 20160301085622 09:40:01 INFO - mozversion platform_changeset: 47eb779302fa63ada9a1f7e10c0107ea0b08a9bd 09:40:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:40:01 INFO - mozversion platform_version: 47.0a1 09:40:01 INFO - using testdate: 1456854001 09:40:01 INFO - actual date: 1456854001 09:40:01 INFO - starting webserver on 'localhost:49882' 09:40:01 INFO - SUITE-START | Running 2 tests 09:40:01 INFO - TEST-START | dromaeo_css 09:40:01 INFO - operating with platform_type : linux_ 09:40:01 INFO - Initialising browser for dromaeo_css test... 09:40:01 INFO - TEST-INFO | started process 3309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfF5vkW/profile http://localhost:49882/getInfo.html) 09:40:06 INFO - PROCESS | 3309 | 09:40:06 INFO - PROCESS | 3309 | (process:3389): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:40:07 INFO - PROCESS | 3309 | __metrics Screen width/height:1600/1200 09:40:07 INFO - PROCESS | 3309 | colorDepth:24 09:40:07 INFO - PROCESS | 3309 | Browser inner width/height: 1024/697 09:40:07 INFO - PROCESS | 3309 | __metrics 09:40:07 ERROR - PROCESS | 3309 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:07 INFO - PROCESS | 3309 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:40:08 INFO - TEST-INFO | 3309: exit 0 09:40:08 INFO - Browser initialized. 09:40:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:08 INFO - TEST-INFO | started process 3441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfF5vkW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:09 INFO - PROCESS | 3441 | 09:40:09 INFO - PROCESS | 3441 | (process:3498): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:40:20 INFO - PROCESS | 3441 | RSS: Main: 161280000 09:40:20 INFO - PROCESS | 3441 | 09:41:10 INFO - PROCESS | 3441 | 1456854070000 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:43:21 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:49882/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49882/tests/dromaeo/cssquery-ext.html) 09:43:22 INFO - PROCESS | 3441 | RSS: Main: 169861120 09:43:22 INFO - PROCESS | 3441 | 09:46:24 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:49882/tests/dromaeo/cssquery-ext.html (next: http://localhost:49882/tests/dromaeo/cssquery-jquery.html) 09:46:25 INFO - PROCESS | 3441 | RSS: Main: 165322752 09:46:25 INFO - PROCESS | 3441 | 09:49:27 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:49882/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49882/tests/dromaeo/cssquery-mootools.html) 09:49:27 INFO - PROCESS | 3441 | RSS: Main: 167219200 09:49:27 INFO - PROCESS | 3441 | 09:52:29 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:49882/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49882/tests/dromaeo/cssquery-prototype.html) 09:52:30 INFO - PROCESS | 3441 | RSS: Main: 164495360 09:52:30 INFO - PROCESS | 3441 | 09:55:32 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:49882/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49882/tests/dromaeo/cssquery-yui.html) 09:55:33 INFO - PROCESS | 3441 | RSS: Main: 164306944 09:55:33 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | Cycle 1(1): loaded http://localhost:49882/tests/dromaeo/cssquery-yui.html (next: http://localhost:49882/tests/dromaeo/cssquery-dojo.html) 09:58:35 INFO - PROCESS | 3441 | RSS: Main: 167903232 09:58:35 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | __start_tp_report 09:58:35 INFO - PROCESS | 3441 | _x_x_mozilla_page_load 09:58:35 INFO - PROCESS | 3441 | _x_x_mozilla_page_load_details 09:58:35 INFO - PROCESS | 3441 | |i|pagename|runs| 09:58:35 INFO - PROCESS | 3441 | |0;dojo.html;2636.9472610547787;2643.8017148713852;2672.26512709005;2688.529507336216;2701.878415471303;4450.777461126947;4544.250198717216;4589.0363023765;4603.40155779749;4623.306504024398;4521.547845215485;4568.063546972871;4595.471520775103;4638.930416043753;4654.115718013583;4212.7682977436225;4215.304474761676;4228.5137209220875;4347.978260108711;4348.043430445297;4218.5148707898525;4277.4867015958125;4288.185244803493;4308.526062133178;4312.935305970397;4230.111676547913;4244.469441319835;4244.808983595745;4246.808893599796;4278.187144442546;4239.851605193834;4260.403543503912;4282.314829627276;4285.3786201000685;4290.635295999844;4145.17096580682;4186.372044193365;4253.404523366731;4254.170436764801;4293.22721910056;4477.955220447819;4488.685791994561;4512.548745125494;4550.954490455086;4574;4887.095887260868;4901.436334821506;4903.583195428393;4916.680415772999;4945.406551213841;4757.904841903177;4877.122118018755;4918.336024636664;4950.851474455772;4968.552830245295;4581.541845815425;4588.678792484561;4590.196715574761;4601.723896566184;4614.307853821953;4947.381577302837;5037.345145131183;5061.645684802029;5083.87290317745;5097.0315640028275;4806.351142595775;4809.302651115569;4816.638752093607;4838.177509823338;4873.829415970424;4806.49531799163;4917.360743103373;4924.187509060965;4929.433115191727;4967.403911530567;4703.0593881223895;4836.12949669063;4837.443693975238;4839.395075615548;4892.217245240744;4803.303520989507;4847.830325938646;4852.805887764521;4882.9755851221225;4901.264810278487;4094.754314741125;4101;4108.67130629549;4139.151473947833;4144.005438694691;3496.7202623790545;3610.927781444409;3611.656892595199;3645.453182022718;3670.0457880951144;4240.257954857888;4247.6389506892265;4261.829526818955;4279.272523670983;4283.378910058024;4914.950850491521;4916.115099282092;4939.950600494021;4967.850964471072;4981.12830254704;4107.774072425986;4257;4266.146770645883;4281.400603915455;4294.291441912112;4433.224185767478;4442.044960333479;4453.888652783641;4467.039586488855;4470.932936005963;4680.110778951988;4681.063787242565;4705.7411842349;4721.126591580569;4743.359646447685;4800.591949684316;4963.925541116814;4990.675606085593;5045.873853153554;5067.822626208065;4641.767911604339;4672.299155126622;4687.601553867823;4694.084653492536;4699.365585645894;4882.170031094794;4884.8046078157895;4888.462269150319;4895.583875370633;4941.43173535048;4814.711117332971;4867.464578896389;4905.8037678492465;4948.430930443045;4976.850694479172;4725.29120631908;4751.714897106184;4763.7141771493825;4771.093492236464;4789.425268967746;4779.30700048498;4786.473487916257;4790.952090479051;4813.542713442217;4864.562189402971;4558.954410455985;4685.062987402602;4733.9763301183275;4740.431148262231;4804;4767.976160119178;4801.063792560417;4801.159797035435;4824.372831531879;4835.468098509091;4698.177818881613;4701.482836888008;4703.129920964632;4706.741129237925;4747.738874361943 09:58:35 INFO - PROCESS | 3441 | |1;ext.html;500.5070006044046;504.7400588696822;528.1865926473231;528.2208742105395;534.4842227250703;31498;32133.357332853328;32171.67828321716;32230.194245143855;32253.51619725703;32486.350272994525;32993.67006329936;33046.66953330466;33059;33172.66827331726;7435.553866767984;7636.579988100652;7696.345810606105;7708.884366734504;7711.498752581092;7619.857021446772;7754.379649628045;7766.57283849388;7770.883436748453;7776.144624091346;7691.115521714991;7698.884516732253;7797.298243158115;7804.492707973964;7805.336546393563;7620.847583048336;7694.692212311501;7702.576358300291;7704.26809453101;7773.144954055049;7413.184549699528;7685.730999414994;7734.03324584427;7764.689412423496;7769.417293702938;32814.83592582022;32872.83563582167;33057;33120.834395827864;33186.33627327464;2195.4201042280074;2473.258022593233;2536.4800215955684;2546.6434699142137;2888.6678032026375;23868.88065559661;25713.742862571322;26293.21120366392;26394;26540.73459265402;3351.882684106069;3367.1413789483768;3368.6294507604143;3369.1240277527772;3456.1359660084977;214482;216055.99999999843;216061;216393;218114;53544.464555353945;53782.462175378525;53799;53896.46103538915;54144.45855541394;57576;57930;58280.41719582835;58408.70795645995;58452;11908.2259653124;12114.878851211552;12251.877481225074;12296.631101066982;12329.075319350904;8635.6977505787;8655.826883462421;8658;8747.343949203836;8827.205551500396;17396.21717022737;17621.559461013578;17827.465176044738;17846.46460606184;18559.35042273514;7239.20368759436;7345.963270183614;7450.85098298031;7528.360089392463;7574.886376704354;780.6916268074079;855.7817756472184;873.9563021849009;907.3331101640289;937.1752857485506;25301.493970120493;25856.22431327063;26110;26302.47395052088;26586.601200982;929.5166513412987;930.6324002019164;934.9065093490733;993.8409854423257;997.2697370062936;13016.349182540835;13584.660383490294;13599.52401665937;13701.931490342484;13705.109167904055;255690;258240;259118;259845;260300;44112.558874410846;44914.77542612331;44946;45097.54902450999;45203.32195017077;1080.0657431322006;1082.978340433187;1124.1681155944543;1124.606387764276;1134.8014097532898;23964.52070958606;25005.374865628506;25672.614910776727;25804.225873223833;26014.60978085368;39186.804065979486;39249.41125883057;39472.21055578815;39698.40452393159;39734.2053158941;243096;243273;243841;244110;245681;29261.561076584294;29439.11682649524;29746.55380169256;29763.851180743957;30142;38415.61584384232;39188.41217381799;39589.60410395859;39908.201835962536;40081;32224.677753222168;33188.1702957428;33759.324813504085;34027.4895876567;34343.48484772781;32619.510707339883;33822.49266260959;33860;33965.49051764275;34062.148446289044;33125;33675.15812104717;33686.49470257899;33863.661363386054;33908.66091339055;29675;29886.701132988394;30067.3986520264;30213.244668883453;30214.848925755232;23816.285511434686;23867.641985369886;24024.75975240295;24271.514569708153;24302.635460467754 09:58:35 INFO - PROCESS | 3441 | |2;jquery.html;311.9703628155326;312.77323940143384;321.96297425796035;325.89897131889103;328.3760854376684;11316.151288653342;15026.474073407418;15380.461683841053;15441.922790386061;15572.377104915804;13774.173549587033;13854.792178117312;14765.11409315439;14810.703785924276;14919.850801491983;4775.80896764129;4935.333729946447;4935.358403407552;4965.677230979993;4973.5772459341;4751.192297309466;4869.196582563891;4871.732054736988;4968.826091086813;4976.552110310071;4875.829345972892;4880.072786170616;4884.877878053059;4941.629377796662;4959.553640172384;4860.198067318888;4870.172070747982;4876;4877.292792545079;4888.486708895568;4194.454720886265;4319.460067491564;4322.740635561876;4340.565943405666;4350.825966961318;17689;17761;17894.642107157913;18031.72952405715;18417.35539256133;1945.863789534733;2034.4303594993426;2075.8546901716886;2153.364757396572;2375.928722138339;12190.39048047594;12231.571894983721;12236.571719989757;12583.119181657288;12688.04839637031;1731.7662115614357;1739.8869073510182;1757.9648407031789;1805.521536792751;1812.900290484023;53176.46823531754;53342;54039.189412158456;54123.99999999961;54426.45573544293;8620.181082797124;8782.473051616924;9058.592363343665;9095.181433671001;9176.90823091774;11477.655670329903;11636.24364416327;11642.708932276591;11659.242149260272;11676.065914726802;6405.903911441332;6419.261784894704;6453.193350831146;6589.4069533742195;6603.70283337251;6197.853397121547;6227.06594010893;6303.180586523814;6339.936600633934;6364.427201551883;5457.5633949283965;5548.750306236229;5556.166575013699;5572.804951826748;5664.376918538957;1639.942602008924;1678.538401939452;1680.3446655804246;1683.1079527850259;1705.8379453951854;784.5136015670207;819.9549024803574;831.4470876866936;833.5748768128299;938.4650749072963;14886.553403397915;15132.773008404884;15243.23783810805;15556.299966501534;15739.370425182864;788.0346575445034;803.6504120707511;815.8939337886155;836.4897412578322;848.5545088828414;8561.272291855263;8798.076201998825;8813.823723525622;8878.200961913459;9074.909250907538;367491;371310;371897;374048;384219;64010.039849402296;64027.35972640214;65584.67207664027;65645.34354656488;66280.33719662837;886.0297973718767;891.3493150000536;909.60432211988;918.3846822628722;919.4575200631659;14127.15237085778;14147.858521414653;14202.076865003743;14264.215468149352;14416.13503189812;30153.698463015087;31515.684843152194;32153.839230803696;32548.186295342806;32827.835860820545;42213.78893105515;44612.776936115115;44748.32877506905;45373.773131134134;45601.54398456106;6931.201371685918;7052.576845389293;7118.928810711826;7150.392216661642;7257.165425976081;8038.196180381915;10729.409882456539;11148.498317575892;11162.274452160584;11316.20786544934;9354.71935841926;9392.765180870532;9606.51967401641;9607.51962401891;9954.55204515813;9339.766505837408;9606.231501479726;9707.174890134418;9809.803803924024;9888.802223955625;9606.951965240409;9851.950740246253;9975.750606234902;10106.343087699275;10160.136388407069;6562;6750.8649827004165;6896.965515172593;6920.7231710731;7216.675249613675;9123.77190570241;9417.811643766949;9455.905440945502;9628.566714497725;9769.853452198366 09:58:35 INFO - PROCESS | 3441 | |3;mootools.html;1278.10532627161;1308.0451270572482;1354.2348573056222;1609.7665838453431;1613.088604938209;5958;6608.867822643544;6706.832329191767;6782.389584937355;6786.185657721074;6753.966230168855;6855.622940738257;6884.380405763481;6898.206706228785;6933.549319294242;1983.4446355020618;2039.4799326171806;2040.2757021257462;2042.121887588344;2044.3355909329528;1976.9901150494227;1982.0684278389206;2029.3303209940684;2096.3710886733993;2096.4025252802953;2030.4010316956533;2049.5798361335965;2054.2091294851516;2069.037897377719;2074.367317968019;2052.8665636733563;2056.92800751973;2067.917283308673;2081.959020489755;2082.864613800106;2031.7866624004414;2042.0402410866868;2045.8977051147383;2061.6186005588866;2062.113291284747;7000.089988301539;7051.788446346566;7059.329363710439;7070.717171313193;7076.044733960901;3936.4882565266616;3989.860354887565;3996.2806694794926;4032.254033003874;4076.164386300801;2502.6621406110125;2611.4515951649987;2613.6863576370765;2633.117905501659;2654.81416300859;867.9913200867974;869.0614136732314;887.7514295997131;901.5627420700955;903.8192361527655;9338.486383248919;9451.149396554274;9520.761980950463;9574.617015319378;9577.760555986086;3633.94549081764;3689.520362352877;3762.172322089136;3778.471014058034;3789.1853251551047;8105.594720264081;8144.714934977247;8215.260626543639;8227.794305142419;8240.175982401712;4054.108096218827;4055.229506393776;4060.4315395844014;4068.816903239361;4093.038136038029;3100.085474784944;3466.913327166841;3488.4069708149677;3635.345637785171;3638.0541059324764;3189.856456459465;3250.1224669339617;3293.4236508610898;3319.0872510059926;3320.8007519548905;1010.5351538292321;1033.1579762493543;1034.99482502587;1041.3283432186197;1049.41757324684;788.3496115704567;825.2325337436242;1056.9471526423802;1063.1335461598771;1066.9466526673634;6221.720022598994;6330.335314791972;6345.1434056401795;6468.126802881645;6503.187101612299;400.5733893403516;401.51617301152044;402.9335159698675;407.5903716764692;407.6596042304709;4915.311856340115;4979.228219625964;5000.549950504472;5001.149804533238;5020.874478138003;7888.447808653454;7975.8404831903035;8129.1464396238725;8142.47073940192;8231.95884020588;8063.395245356504;8089.069756977905;8096;8101.87847182281;8128.309093727099;6453.128827608213;6488.059231411513;6560.212774467094;6606.405423511907;6621.668916554153;6179.721912513858;6223.159873417212;6230.7819226326865;6285.49716022708;6297.685115744286;7085.716571337089;7120.893186602101;7158.749443769443;7338.376238019615;7540.547567145989;7422.351739769531;7565.697372105275;7584.014078169803;7672.5012874163;7700.306972372513;5199.55803756685;5879.382664820132;6026.0659597762415;6138.907916381168;6198.845028874314;6454.548181627241;6513.4463570595135;6527.608343499215;6530.640814755234;6542.182227221598;5850.561207909339;5960.761569537343;6178.258608966953;6220.595661282002;6286.214223222098;5852.209951656642;5922.1412895130825;6018.8194354169445;6042.395760423922;6065.909011364922;5852.326982397079;5876.294844618673;5882.058870580687;5905.261842269716;5940.8811823764145;5707.086866101404;5729.427057294237;5752.827415177551;5764.481196692318;5897.351291358033;5850;5893.32226793907;5974.103884417372;5987.401259873977;6019.939800601938 09:58:35 INFO - PROCESS | 3441 | |4;prototype.html;276.87540606726975;282.8840175528034;285.1360378054496;287.90355230997613;287.92173310950494;5668.489835914766;5720.656760594367;5722.599418040739;5727.713614319283;5758.165066065418;5622.072358060915;5624.465675760796;5624.887502249962;5630.465105814941;5632.690202038886;4043.3126368517273;4177;4259.595338442843;4261.637760790337;4266.57334266574;4249.830006799724;4253.680973926952;4258.190943720699;4260.275753121961;4264.893377665552;4242.448481697375;4287.592678695534;4291.549387314319;4292;4306.0526684129445;4289;4291.163223171498;4291.291936830419;4304.354346847967;4308.46144231971;3701.38927077032;3722.609126041754;3732.6640602345647;3732.720045996561;3733.626637336272;5411.512963833235;5412.621116521806;5413.9729301353245;5417.6478528895495;5430.239766432703;4589.219832628428;4699.107169637792;4702.224133018048;4708.387909571768;4895.853124406273;5822.708864556797;5847.736851841635;5853.1220316952795;5856;5861.2087368205175;3833.961660383416;3842.846286148551;3845.1925095729653;3845.4231865220163;3859.864904728321;6098.664573448458;6183.7835675751585;6189.566730328879;6189.752409903554;6196.070589411579;3966.5636779954184;3968.761874287552;3979.801009949491;3980.343243364812;3985.442038114666;4040.4949381327333;4044.4944381952255;4045.2314060328445;4046.2514434829063;4059.69552283574;4516.751578663205;4612.077584483117;4625.421822272216;4636.466806317249;4636.86089417318;5797.217375654317;5843.0651095825315;5846.883062338729;5849.707514624251;5888.205092312569;1406.7186562687502;1435.4186554445466;1435.7056803355288;1436.1813766153193;1437.6405898525368;910.8588168833842;922.9077092290718;927.758782716485;945.2485274207022;948.8244674735196;5077.1876499759865;5084.237364395371;5086.669366491166;5090.618203634742;5095.643304968691;6128.632282063001;6139.3553676863285;6143.262808463013;6145.678679084019;6147.262328520516;4910.919597688503;4995.425526064477;5052.974735126374;5083.517065878809;5105.438401775802;3319.767616266838;3358.261182539837;3366.9899030290817;3372.51098590703;3373.578302712161;5777.508911742549;5818.389069147678;5852.239208902815;5895.380984996514;5898.439648233411;6414.743410263537;6436.710348034349;6461.418472337512;6472.676366181766;6476.870462590816;5779.884402312015;5806.767729290866;5808.94191058084;5824.213731146326;5824.767009319579;6021.879562408815;6184.907226391518;6262;6262.342454042442;6265.373462653698;6049.153118563317;6081.817545473643;6083.452489275809;6090.147379366804;6096.390360963868;5753.482186603226;5809.128630705428;5812.534997200299;5815.883682326415;5839.532837372915;3970.3250447424584;4024.7182697212083;4028.6575641070835;4035.071933455263;4038.1318016626565;6091.086337049301;6190.380961903954;6207.937920620917;6214.130021796862;6225.284092329259;5784.4504772046585;5957.314908785372;5977.641341519523;6005.87988240224;6015.218021657157;5950.821475355746;5971.731272092853;5972.104184372379;5980.43185897339;5991;5822.912656310244;5839.912401314069;5859.94140058611;5860.2967643883;5872.236609240771;5997.850053748692;6001.729922153426;6010.188624535632;6015.248093988252;6025.367336429787;5637.548996080386;5804.245448091721;5816.883662326645;5863.2670916135485;5908.084246941731 09:58:35 INFO - PROCESS | 3441 | |5;yui.html;655.4854439265177;658.5906160815855;661.1108059659759;675.8817206988775;678.1929503890367;10441.164706823454;10713.196510261723;10738.946305268482;10832.729181770459;10850.620228292011;10128.341657792256;10802.891971080306;11010.779784404307;11027.669169924915;11030.558777648905;579.8608333999852;681;682.7200847652464;692.8545005548841;693.8300116471446;679.5039621076617;683.8290427393151;685.540687739216;691.3432239372592;692.7679227458807;721.3688022979893;722.072137303565;724.0840336973732;724.7789424225609;724.8115489972593;712.2485777504704;715.2632788228134;715.4169351978121;716.3695947566108;717.5049216040941;535.2292698514127;535.4377903201662;536.471575498134;536.7021303176736;537.1325309624966;10863.402512861789;10895.291806032583;10956.726081847937;10963.83554246687;11021.228514004022;10111.544980475895;10478.895211047868;10550.472476376228;10632.25574209798;10902.25563909771;8731.214190722802;8762.255208307302;8810.427322224099;8940.821183576358;8945.64217431302;2944.175630823373;3097.349556593118;3111.859966301522;3112.6264848218357;3164.6360668523184;40295.59704402948;41603.1679366414;43395.566044339466;43636.345454818205;43786.34320485163;8559.22966932979;8618.396712230084;8619.827603447897;8640.049594544595;8684.826303473896;14101.012929094864;14279.78580321296;14289.64275893111;14374.137551746928;14513.709725805636;6171.475424588871;6223.813285601439;6301.4328710416285;6342.682865856688;6370.8088757337355;3444.431668774674;3517.9120521986642;3580.946285805715;3619.077135330474;3628.9455658165148;2481.3424442522746;2514;2526.7978561715386;2530.329462692388;2531.5063562605483;468.91559519286176;474.3734152404914;478.1966296621709;479.6330806932699;488.7995921672169;492.68714366377606;508.7227461033672;513.9922901156485;524.4912434938104;536.8201652446396;6660.833479162963;6751.122354094035;6779.457643388517;6811.875693673727;6931.861362772716;493.64704236471096;522.0941666209125;530.1649901405302;536.3028063517412;545.4055079962859;3280.4751239801517;3341.615714192899;3430.2281986552825;3458.4466485362723;3531.1525233943667;50357.748211259444;51193.23210151851;51218.74390628023;51339.48660513422;51353.48646513487;45537.54462455399;45854.54145458503;46035;46142.30786538205;46553.76723116363;40839;41259.58740412618;41583.960400989614;41731.79134104371;41808.58191418108;6803.25164231944;6816.113905192294;6848.726050958106;6984.057152284579;6994.790156295319;30425.543616845323;31223.063308100795;32446.675533244364;33018.834905825315;33186.33627327392;36109.63890361168;40394;40971.38542921799;41198.38202427026;41290.38064428976;9206.815863682556;9416.435013899189;9516.095970882756;9669.9033009669;9690.903090969283;10253.74365640865;10258.230632702427;10515.684529464128;10881.292715973437;11343.319400835977;9997.100260976547;10118.392896426238;10442.321249118782;10714.624988125379;10832.620858269922;8751.343649226206;9274.072592740942;9347.252219822534;9400.81198376015;9937.850932235877;9404.200642945427;9449.149576538144;9467.479288639192;9478.95260523693;9585.185259252763;8304.855245341481;8324.0076197297;8339;8408.159184081544;8413.747587572383;7949.523028618301;7992.960035199787;8051.275385215359;8076.415547024895;8213.876791848246 09:58:35 INFO - PROCESS | 3441 | __end_tp_report 09:58:35 INFO - PROCESS | 3441 | __start_cc_report 09:58:35 INFO - PROCESS | 3441 | _x_x_mozilla_cycle_collect,354 09:58:35 INFO - PROCESS | 3441 | __end_cc_report 09:58:35 INFO - PROCESS | 3441 | __startTimestamp1456855115915__endTimestamp 09:58:35 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | ------- Summary: start ------- 09:58:35 INFO - PROCESS | 3441 | Number of tests: 6 09:58:35 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | [#0] dojo.html Cycles:165 Average:4548.01 Median:4694.08 stddev:462.46 (9.9%) stddev-sans-first:438.90 09:58:35 INFO - PROCESS | 3441 | Values: 2636.9 2643.8 2672.3 2688.5 2701.9 4450.8 4544.3 4589.0 4603.4 4623.3 4521.5 4568.1 4595.5 4638.9 4654.1 4212.8 4215.3 4228.5 4348.0 4348.0 4218.5 4277.5 4288.2 4308.5 4312.9 4230.1 4244.5 4244.8 4246.8 4278.2 4239.9 4260.4 4282.3 4285.4 4290.6 4145.2 4186.4 4253.4 4254.2 4293.2 4478.0 4488.7 4512.5 4551.0 4574.0 4887.1 4901.4 4903.6 4916.7 4945.4 4757.9 4877.1 4918.3 4950.9 4968.6 4581.5 4588.7 4590.2 4601.7 4614.3 4947.4 5037.3 5061.6 5083.9 5097.0 4806.4 4809.3 4816.6 4838.2 4873.8 4806.5 4917.4 4924.2 4929.4 4967.4 4703.1 4836.1 4837.4 4839.4 4892.2 4803.3 4847.8 4852.8 4883.0 4901.3 4094.8 4101.0 4108.7 4139.2 4144.0 3496.7 3610.9 3611.7 3645.5 3670.0 4240.3 4247.6 4261.8 4279.3 4283.4 4915.0 4916.1 4940.0 4967.9 4981.1 4107.8 4257.0 4266.1 4281.4 4294.3 4433.2 4442.0 4453.9 4467.0 4470.9 4680.1 4681.1 4705.7 4721.1 4743.4 4800.6 4963.9 4990.7 5045.9 5067.8 4641.8 4672.3 4687.6 4694.1 4699.4 4882.2 4884.8 4888.5 4895.6 4941.4 4814.7 4867.5 4905.8 4948.4 4976.9 4725.3 4751.7 4763.7 4771.1 4789.4 4779.3 4786.5 4791.0 4813.5 4864.6 4559.0 4685.1 4734.0 4740.4 4804.0 4768.0 4801.1 4801.2 4824.4 4835.5 4698.2 4701.5 4703.1 4706.7 4747.7 09:58:35 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | [#1] ext.html Cycles:180 Average:39494.77 Median:18521.15 stddev:62639.63 (338.2%) stddev-sans-first:62746.93 09:58:35 INFO - PROCESS | 3441 | Values: 500.5 504.7 528.2 528.2 534.5 31498.0 32133.4 32171.7 32230.2 32253.5 32486.4 32993.7 33046.7 33059.0 33172.7 7435.6 7636.6 7696.3 7708.9 7711.5 7619.9 7754.4 7766.6 7770.9 7776.1 7691.1 7698.9 7797.3 7804.5 7805.3 7620.8 7694.7 7702.6 7704.3 7773.1 7413.2 7685.7 7734.0 7764.7 7769.4 32814.8 32872.8 33057.0 33120.8 33186.3 2195.4 2473.3 2536.5 2546.6 2888.7 23868.9 25713.7 26293.2 26394.0 26540.7 3351.9 3367.1 3368.6 3369.1 3456.1 214482.0 216056.0 216061.0 216393.0 218114.0 53544.5 53782.5 53799.0 53896.5 54144.5 57576.0 57930.0 58280.4 58408.7 58452.0 11908.2 12114.9 12251.9 12296.6 12329.1 8635.7 8655.8 8658.0 8747.3 8827.2 17396.2 17621.6 17827.5 17846.5 18559.4 7239.2 7346.0 7450.9 7528.4 7574.9 780.7 855.8 874.0 907.3 937.2 25301.5 25856.2 26110.0 26302.5 26586.6 929.5 930.6 934.9 993.8 997.3 13016.3 13584.7 13599.5 13701.9 13705.1 255690.0 258240.0 259118.0 259845.0 260300.0 44112.6 44914.8 44946.0 45097.5 45203.3 1080.1 1083.0 1124.2 1124.6 1134.8 23964.5 25005.4 25672.6 25804.2 26014.6 39186.8 39249.4 39472.2 39698.4 39734.2 243096.0 243273.0 243841.0 244110.0 245681.0 29261.6 29439.1 29746.6 29763.9 30142.0 38415.6 39188.4 39589.6 39908.2 40081.0 32224.7 33188.2 33759.3 34027.5 34343.5 32619.5 33822.5 33860.0 33965.5 34062.1 33125.0 33675.2 33686.5 33863.7 33908.7 29675.0 29886.7 30067.4 30213.2 30214.8 23816.3 23867.6 24024.8 24271.5 24302.6 09:58:35 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | [#2] jquery.html Cycles:180 Average:22253.65 Median:4882.48 stddev:61296.72 (1255.4%) stddev-sans-first:61446.54 09:58:35 INFO - PROCESS | 3441 | Values: 312.0 312.8 322.0 325.9 328.4 11316.2 15026.5 15380.5 15441.9 15572.4 13774.2 13854.8 14765.1 14810.7 14919.9 4775.8 4935.3 4935.4 4965.7 4973.6 4751.2 4869.2 4871.7 4968.8 4976.6 4875.8 4880.1 4884.9 4941.6 4959.6 4860.2 4870.2 4876.0 4877.3 4888.5 4194.5 4319.5 4322.7 4340.6 4350.8 17689.0 17761.0 17894.6 18031.7 18417.4 1945.9 2034.4 2075.9 2153.4 2375.9 12190.4 12231.6 12236.6 12583.1 12688.0 1731.8 1739.9 1758.0 1805.5 1812.9 53176.5 53342.0 54039.2 54124.0 54426.5 8620.2 8782.5 9058.6 9095.2 9176.9 11477.7 11636.2 11642.7 11659.2 11676.1 6405.9 6419.3 6453.2 6589.4 6603.7 6197.9 6227.1 6303.2 6339.9 6364.4 5457.6 5548.8 5556.2 5572.8 5664.4 1639.9 1678.5 1680.3 1683.1 1705.8 784.5 820.0 831.4 833.6 938.5 14886.6 15132.8 15243.2 15556.3 15739.4 788.0 803.7 815.9 836.5 848.6 8561.3 8798.1 8813.8 8878.2 9074.9 367491.0 371310.0 371897.0 374048.0 384219.0 64010.0 64027.4 65584.7 65645.3 66280.3 886.0 891.3 909.6 918.4 919.5 14127.2 14147.9 14202.1 14264.2 14416.1 30153.7 31515.7 32153.8 32548.2 32827.8 42213.8 44612.8 44748.3 45373.8 45601.5 6931.2 7052.6 7118.9 7150.4 7257.2 8038.2 10729.4 11148.5 11162.3 11316.2 9354.7 9392.8 9606.5 9607.5 9954.6 9339.8 9606.2 9707.2 9809.8 9888.8 9607.0 9852.0 9975.8 10106.3 10160.1 6562.0 6750.9 6897.0 6920.7 7216.7 9123.8 9417.8 9455.9 9628.6 9769.9 09:58:35 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | [#3] mootools.html Cycles:180 Average:4764.13 Median:5895.34 stddev:2501.55 (42.4%) stddev-sans-first:2494.85 09:58:35 INFO - PROCESS | 3441 | Values: 1278.1 1308.0 1354.2 1609.8 1613.1 5958.0 6608.9 6706.8 6782.4 6786.2 6754.0 6855.6 6884.4 6898.2 6933.5 1983.4 2039.5 2040.3 2042.1 2044.3 1977.0 1982.1 2029.3 2096.4 2096.4 2030.4 2049.6 2054.2 2069.0 2074.4 2052.9 2056.9 2067.9 2082.0 2082.9 2031.8 2042.0 2045.9 2061.6 2062.1 7000.1 7051.8 7059.3 7070.7 7076.0 3936.5 3989.9 3996.3 4032.3 4076.2 2502.7 2611.5 2613.7 2633.1 2654.8 868.0 869.1 887.8 901.6 903.8 9338.5 9451.1 9520.8 9574.6 9577.8 3633.9 3689.5 3762.2 3778.5 3789.2 8105.6 8144.7 8215.3 8227.8 8240.2 4054.1 4055.2 4060.4 4068.8 4093.0 3100.1 3466.9 3488.4 3635.3 3638.1 3189.9 3250.1 3293.4 3319.1 3320.8 1010.5 1033.2 1035.0 1041.3 1049.4 788.3 825.2 1056.9 1063.1 1066.9 6221.7 6330.3 6345.1 6468.1 6503.2 400.6 401.5 402.9 407.6 407.7 4915.3 4979.2 5000.5 5001.1 5020.9 7888.4 7975.8 8129.1 8142.5 8232.0 8063.4 8089.1 8096.0 8101.9 8128.3 6453.1 6488.1 6560.2 6606.4 6621.7 6179.7 6223.2 6230.8 6285.5 6297.7 7085.7 7120.9 7158.7 7338.4 7540.5 7422.4 7565.7 7584.0 7672.5 7700.3 5199.6 5879.4 6026.1 6138.9 6198.8 6454.5 6513.4 6527.6 6530.6 6542.2 5850.6 5960.8 6178.3 6220.6 6286.2 5852.2 5922.1 6018.8 6042.4 6065.9 5852.3 5876.3 5882.1 5905.3 5940.9 5707.1 5729.4 5752.8 5764.5 5897.4 5850.0 5893.3 5974.1 5987.4 6019.9 09:58:35 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | [#4] prototype.html Cycles:180 Average:4856.56 Median:5653.02 stddev:1489.69 (26.4%) stddev-sans-first:1453.68 09:58:35 INFO - PROCESS | 3441 | Values: 276.9 282.9 285.1 287.9 287.9 5668.5 5720.7 5722.6 5727.7 5758.2 5622.1 5624.5 5624.9 5630.5 5632.7 4043.3 4177.0 4259.6 4261.6 4266.6 4249.8 4253.7 4258.2 4260.3 4264.9 4242.4 4287.6 4291.5 4292.0 4306.1 4289.0 4291.2 4291.3 4304.4 4308.5 3701.4 3722.6 3732.7 3732.7 3733.6 5411.5 5412.6 5414.0 5417.6 5430.2 4589.2 4699.1 4702.2 4708.4 4895.9 5822.7 5847.7 5853.1 5856.0 5861.2 3834.0 3842.8 3845.2 3845.4 3859.9 6098.7 6183.8 6189.6 6189.8 6196.1 3966.6 3968.8 3979.8 3980.3 3985.4 4040.5 4044.5 4045.2 4046.3 4059.7 4516.8 4612.1 4625.4 4636.5 4636.9 5797.2 5843.1 5846.9 5849.7 5888.2 1406.7 1435.4 1435.7 1436.2 1437.6 910.9 922.9 927.8 945.2 948.8 5077.2 5084.2 5086.7 5090.6 5095.6 6128.6 6139.4 6143.3 6145.7 6147.3 4910.9 4995.4 5053.0 5083.5 5105.4 3319.8 3358.3 3367.0 3372.5 3373.6 5777.5 5818.4 5852.2 5895.4 5898.4 6414.7 6436.7 6461.4 6472.7 6476.9 5779.9 5806.8 5808.9 5824.2 5824.8 6021.9 6184.9 6262.0 6262.3 6265.4 6049.2 6081.8 6083.5 6090.1 6096.4 5753.5 5809.1 5812.5 5815.9 5839.5 3970.3 4024.7 4028.7 4035.1 4038.1 6091.1 6190.4 6207.9 6214.1 6225.3 5784.5 5957.3 5977.6 6005.9 6015.2 5950.8 5971.7 5972.1 5980.4 5991.0 5822.9 5839.9 5859.9 5860.3 5872.2 5997.9 6001.7 6010.2 6015.2 6025.4 5637.5 5804.2 5816.9 5863.3 5908.1 09:58:35 INFO - PROCESS | 3441 | 09:58:35 INFO - PROCESS | 3441 | [#5] yui.html Cycles:180 Average:11993.57 Median:25926.74 stddev:14312.27 (55.2%) stddev-sans-first:14327.09 09:58:35 INFO - PROCESS | 3441 | Values: 655.5 658.6 661.1 675.9 678.2 10441.2 10713.2 10738.9 10832.7 10850.6 10128.3 10802.9 11010.8 11027.7 11030.6 579.9 681.0 682.7 692.9 693.8 679.5 683.8 685.5 691.3 692.8 721.4 722.1 724.1 724.8 724.8 712.2 715.3 715.4 716.4 717.5 535.2 535.4 536.5 536.7 537.1 10863.4 10895.3 10956.7 10963.8 11021.2 10111.5 10478.9 10550.5 10632.3 10902.3 8731.2 8762.3 8810.4 8940.8 8945.6 2944.2 3097.3 3111.9 3112.6 3164.6 40295.6 41603.2 43395.6 43636.3 43786.3 8559.2 8618.4 8619.8 8640.0 8684.8 14101.0 14279.8 14289.6 14374.1 14513.7 6171.5 6223.8 6301.4 6342.7 6370.8 3444.4 3517.9 3580.9 3619.1 3628.9 2481.3 2514.0 2526.8 2530.3 2531.5 468.9 474.4 478.2 479.6 488.8 492.7 508.7 514.0 524.5 536.8 6660.8 6751.1 6779.5 6811.9 6931.9 493.6 522.1 530.2 536.3 545.4 3280.5 3341.6 3430.2 3458.4 3531.2 50357.7 51193.2 51218.7 51339.5 51353.5 45537.5 45854.5 46035.0 46142.3 46553.8 40839.0 41259.6 41584.0 41731.8 41808.6 6803.3 6816.1 6848.7 6984.1 6994.8 30425.5 31223.1 32446.7 33018.8 33186.3 36109.6 40394.0 40971.4 41198.4 41290.4 9206.8 9416.4 9516.1 9669.9 9690.9 10253.7 10258.2 10515.7 10881.3 11343.3 9997.1 10118.4 10442.3 10714.6 10832.6 8751.3 9274.1 9347.3 9400.8 9937.9 9404.2 9449.1 9467.5 9479.0 9585.2 8304.9 8324.0 8339.0 8408.2 8413.7 7949.5 7993.0 8051.3 8076.4 8213.9 09:58:35 INFO - PROCESS | 3441 | -------- Summary: end -------- 09:58:35 INFO - PROCESS | 3441 | 09:58:36 INFO - PROCESS | 3441 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:36 INFO - PROCESS | 3441 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:36 INFO - PROCESS | 3441 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:36 INFO - PROCESS | 3441 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:36 INFO - PROCESS | 3441 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:36 INFO - PROCESS | 3441 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:36 INFO - PROCESS | 3441 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:36 INFO - PROCESS | 3441 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:36 INFO - TEST-INFO | 3441: exit 0 09:58:36 INFO - TEST-OK | dromaeo_css | took 1114792ms 09:58:36 INFO - TEST-START | kraken 09:58:36 INFO - operating with platform_type : linux_ 09:58:36 INFO - Initialising browser for kraken test... 09:58:36 INFO - TEST-INFO | started process 3673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5op5Xh/profile http://localhost:49882/getInfo.html) 09:58:40 INFO - PROCESS | 3673 | 09:58:40 INFO - PROCESS | 3673 | (process:3742): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:58:40 INFO - PROCESS | 3673 | __metrics Screen width/height:1600/1200 09:58:40 INFO - PROCESS | 3673 | colorDepth:24 09:58:40 INFO - PROCESS | 3673 | Browser inner width/height: 1024/697 09:58:40 INFO - PROCESS | 3673 | __metrics 09:58:41 ERROR - PROCESS | 3673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:41 INFO - PROCESS | 3673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:58:42 INFO - TEST-INFO | 3673: exit 0 09:58:42 INFO - Browser initialized. 09:58:42 INFO - Running cycle 1/1 for kraken test... 09:58:42 INFO - TEST-INFO | started process 3793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5op5Xh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:43 INFO - PROCESS | 3793 | 09:58:43 INFO - PROCESS | 3793 | (process:3850): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:58:54 INFO - PROCESS | 3793 | RSS: Main: 161574912 09:58:54 INFO - PROCESS | 3793 | 09:58:56 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49882/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:57 INFO - PROCESS | 3793 | RSS: Main: 168574976 09:58:57 INFO - PROCESS | 3793 | 09:59:00 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49882/tests/kraken/driver.html?testName=audio-dft) 09:59:00 INFO - PROCESS | 3793 | RSS: Main: 169865216 09:59:00 INFO - PROCESS | 3793 | 09:59:03 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49882/tests/kraken/driver.html?testName=audio-fft) 09:59:04 INFO - PROCESS | 3793 | RSS: Main: 164651008 09:59:04 INFO - PROCESS | 3793 | 09:59:06 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49882/tests/kraken/driver.html?testName=audio-oscillator) 09:59:07 INFO - PROCESS | 3793 | RSS: Main: 164696064 09:59:07 INFO - PROCESS | 3793 | 09:59:09 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49882/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:09 INFO - PROCESS | 3793 | RSS: Main: 163471360 09:59:09 INFO - PROCESS | 3793 | 09:59:13 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49882/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:13 INFO - PROCESS | 3793 | RSS: Main: 163635200 09:59:13 INFO - PROCESS | 3793 | 09:59:17 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49882/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:17 INFO - PROCESS | 3793 | RSS: Main: 167915520 09:59:17 INFO - PROCESS | 3793 | 09:59:20 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49882/tests/kraken/driver.html?testName=json-parse-financial) 09:59:21 INFO - PROCESS | 3793 | RSS: Main: 166219776 09:59:21 INFO - PROCESS | 3793 | 09:59:22 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49882/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:23 INFO - PROCESS | 3793 | RSS: Main: 167391232 09:59:23 INFO - PROCESS | 3793 | 09:59:25 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49882/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:26 INFO - PROCESS | 3793 | RSS: Main: 166694912 09:59:26 INFO - PROCESS | 3793 | 09:59:29 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49882/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:29 INFO - PROCESS | 3793 | RSS: Main: 166289408 09:59:29 INFO - PROCESS | 3793 | 09:59:32 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:32 INFO - PROCESS | 3793 | RSS: Main: 166875136 09:59:32 INFO - PROCESS | 3793 | 09:59:35 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:36 INFO - PROCESS | 3793 | RSS: Main: 166572032 09:59:36 INFO - PROCESS | 3793 | 09:59:37 INFO - PROCESS | 3793 | Cycle 1(1): loaded http://localhost:49882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49882/tests/kraken/driver.html?testName=ai-astar) 09:59:38 INFO - PROCESS | 3793 | RSS: Main: 168955904 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | __start_tp_report 09:59:38 INFO - PROCESS | 3793 | _x_x_mozilla_page_load 09:59:38 INFO - PROCESS | 3793 | _x_x_mozilla_page_load_details 09:59:38 INFO - PROCESS | 3793 | |i|pagename|runs| 09:59:38 INFO - PROCESS | 3793 | |0;ai-astar;119;110;114;115;114;125;115;114;114;115 09:59:38 INFO - PROCESS | 3793 | |1;audio-beat-detection;170;134;154;183;141;160;157;134;176;143 09:59:38 INFO - PROCESS | 3793 | |2;audio-dft;162;164;163;163;165;173;161;162;165;162 09:59:38 INFO - PROCESS | 3793 | |3;audio-fft;75;73;75;161;75;78;74;74;152;74 09:59:38 INFO - PROCESS | 3793 | |4;audio-oscillator;95;96;149;95;95;94;140;96;95;143 09:59:38 INFO - PROCESS | 3793 | |5;imaging-gaussian-blur;118;119;118;118;118;118;118;118;117;118 09:59:38 INFO - PROCESS | 3793 | |6;imaging-darkroom;148;148;148;147;148;147;147;148;147;148 09:59:38 INFO - PROCESS | 3793 | |7;imaging-desaturate;96;97;96;96;96;96;96;97;96;96 09:59:38 INFO - PROCESS | 3793 | |8;json-parse-financial;68;68;68;66;68;67;68;75;67;65 09:59:38 INFO - PROCESS | 3793 | |9;json-stringify-tinderbox;70;72;70;70;70;72;72;71;71;71 09:59:38 INFO - PROCESS | 3793 | |10;stanford-crypto-aes;88;86;85;85;84;86;85;84;84;84 09:59:38 INFO - PROCESS | 3793 | |11;stanford-crypto-ccm;121;120;118;123;119;140;120;122;119;131 09:59:38 INFO - PROCESS | 3793 | |12;stanford-crypto-pbkdf2;155;155;151;150;149;139;158;151;152;147 09:59:38 INFO - PROCESS | 3793 | |13;stanford-crypto-sha256-iterative;71;70;72;71;71;70;71;73;71;74 09:59:38 INFO - PROCESS | 3793 | __end_tp_report 09:59:38 INFO - PROCESS | 3793 | __start_cc_report 09:59:38 INFO - PROCESS | 3793 | _x_x_mozilla_cycle_collect,876 09:59:38 INFO - PROCESS | 3793 | __end_cc_report 09:59:38 INFO - PROCESS | 3793 | __startTimestamp1456855178172__endTimestamp 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | ------- Summary: start ------- 09:59:38 INFO - PROCESS | 3793 | Number of tests: 14 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:3.98 (3.5%) stddev-sans-first:4.01 09:59:38 INFO - PROCESS | 3793 | Values: 119.0 110.0 114.0 115.0 114.0 125.0 115.0 114.0 114.0 115.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:158.50 stddev:17.33 (10.9%) stddev-sans-first:17.53 09:59:38 INFO - PROCESS | 3793 | Values: 170.0 134.0 154.0 183.0 141.0 160.0 157.0 134.0 176.0 143.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.43 (2.1%) stddev-sans-first:3.56 09:59:38 INFO - PROCESS | 3793 | Values: 162.0 164.0 163.0 163.0 165.0 173.0 161.0 162.0 165.0 162.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#3] audio-fft Cycles:10 Average:91.10 Median:74.50 stddev:34.56 (46.4%) stddev-sans-first:36.16 09:59:38 INFO - PROCESS | 3793 | Values: 75.0 73.0 75.0 161.0 75.0 78.0 74.0 74.0 152.0 74.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.00 stddev:23.71 (25.0%) stddev-sans-first:24.53 09:59:38 INFO - PROCESS | 3793 | Values: 95.0 96.0 149.0 95.0 95.0 94.0 140.0 96.0 95.0 143.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:59:38 INFO - PROCESS | 3793 | Values: 118.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 09:59:38 INFO - PROCESS | 3793 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 148.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:59:38 INFO - PROCESS | 3793 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:2.67 (3.9%) stddev-sans-first:2.83 09:59:38 INFO - PROCESS | 3793 | Values: 68.0 68.0 68.0 66.0 68.0 67.0 68.0 75.0 67.0 65.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:0.88 (1.2%) stddev-sans-first:0.87 09:59:38 INFO - PROCESS | 3793 | Values: 70.0 72.0 70.0 70.0 70.0 72.0 72.0 71.0 71.0 71.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:1.29 (1.5%) stddev-sans-first:0.83 09:59:38 INFO - PROCESS | 3793 | Values: 88.0 86.0 85.0 85.0 84.0 86.0 85.0 84.0 84.0 84.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:121.50 stddev:6.93 (5.7%) stddev-sans-first:7.30 09:59:38 INFO - PROCESS | 3793 | Values: 121.0 120.0 118.0 123.0 119.0 140.0 120.0 122.0 119.0 131.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:151.50 stddev:5.23 (3.5%) stddev-sans-first:5.31 09:59:38 INFO - PROCESS | 3793 | Values: 155.0 155.0 151.0 150.0 149.0 139.0 158.0 151.0 152.0 147.0 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:1.26 (1.8%) stddev-sans-first:1.33 09:59:38 INFO - PROCESS | 3793 | Values: 71.0 70.0 72.0 71.0 71.0 70.0 71.0 73.0 71.0 74.0 09:59:38 INFO - PROCESS | 3793 | -------- Summary: end -------- 09:59:38 INFO - PROCESS | 3793 | 09:59:38 INFO - PROCESS | 3793 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:59:38 INFO - PROCESS | 3793 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:59:38 INFO - PROCESS | 3793 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:59:38 INFO - PROCESS | 3793 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:59:38 INFO - PROCESS | 3793 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:59:38 INFO - PROCESS | 3793 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:59:38 INFO - PROCESS | 3793 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 09:59:39 INFO - TEST-INFO | 3793: exit 0 09:59:39 INFO - TEST-OK | kraken | took 62529ms 09:59:39 INFO - SUITE-END | took 1177s 09:59:39 INFO - Completed test suite (00:19:37) 09:59:39 INFO - Working with test: dromaeo_css 09:59:39 INFO - Generating results file: dromaeo_css 09:59:39 INFO - Working with test: kraken 09:59:39 INFO - Generating results file: kraken 09:59:39 INFO - javascript benchmark 09:59:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:59:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 09:59:39 INFO - process_Request line: dromaeo_css 6061.47 graph.html#tests=[[72,132,43]] 09:59:39 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:59:39 INFO - process_Request line: kraken 1566.80 graph.html#tests=[[232,132,43]] 09:59:39 INFO - RETURN: dromaeo_css: 6061.47 09:59:39 INFO - RETURN: kraken: 1566.80 09:59:39 INFO - javascript benchmark 09:59:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2636.9472610547787, 2643.8017148713852, 2672.26512709005, 2688.529507336216, 2701.878415471303, 4450.777461126947, 4544.250198717216, 4589.0363023765, 4603.40155779749, 4623.306504024398, 4521.547845215485, 4568.063546972871, 4595.471520775103, 4638.930416043753, 4654.115718013583, 4212.7682977436225, 4215.304474761676, 4228.5137209220875, 4347.978260108711, 4348.043430445297, 4218.5148707898525, 4277.4867015958125, 4288.185244803493, 4308.526062133178, 4312.935305970397, 4230.111676547913, 4244.469441319835, 4244.808983595745, 4246.808893599796, 4278.187144442546, 4239.851605193834, 4260.403543503912, 4282.314829627276, 4285.3786201000685, 4290.635295999844, 4145.17096580682, 4186.372044193365, 4253.404523366731, 4254.170436764801, 4293.22721910056, 4477.955220447819, 4488.685791994561, 4512.548745125494, 4550.954490455086, 4574.0, 4887.095887260868, 4901.436334821506, 4903.583195428393, 4916.680415772999, 4945.406551213841, 4757.904841903177, 4877.122118018755, 4918.336024636664, 4950.851474455772, 4968.552830245295, 4581.541845815425, 4588.678792484561, 4590.196715574761, 4601.723896566184, 4614.307853821953, 4947.381577302837, 5037.345145131183, 5061.645684802029, 5083.87290317745, 5097.0315640028275, 4806.351142595775, 4809.302651115569, 4816.638752093607, 4838.177509823338, 4873.829415970424, 4806.49531799163, 4917.360743103373, 4924.187509060965, 4929.433115191727, 4967.403911530567, 4703.0593881223895, 4836.12949669063, 4837.443693975238, 4839.395075615548, 4892.217245240744, 4803.303520989507, 4847.830325938646, 4852.805887764521, 4882.9755851221225, 4901.264810278487, 4094.754314741125, 4101.0, 4108.67130629549, 4139.151473947833, 4144.005438694691, 3496.7202623790545, 3610.927781444409, 3611.656892595199, 3645.453182022718, 3670.0457880951144, 4240.257954857888, 4247.6389506892265, 4261.829526818955, 4279.272523670983, 4283.378910058024, 4914.950850491521, 4916.115099282092, 4939.950600494021, 4967.850964471072, 4981.12830254704, 4107.774072425986, 4257.0, 4266.146770645883, 4281.400603915455, 4294.291441912112, 4433.224185767478, 4442.044960333479, 4453.888652783641, 4467.039586488855, 4470.932936005963, 4680.110778951988, 4681.063787242565, 4705.7411842349, 4721.126591580569, 4743.359646447685, 4800.591949684316, 4963.925541116814, 4990.675606085593, 5045.873853153554, 5067.822626208065, 4641.767911604339, 4672.299155126622, 4687.601553867823, 4694.084653492536, 4699.365585645894, 4882.170031094794, 4884.8046078157895, 4888.462269150319, 4895.583875370633, 4941.43173535048, 4814.711117332971, 4867.464578896389, 4905.8037678492465, 4948.430930443045, 4976.850694479172, 4725.29120631908, 4751.714897106184, 4763.7141771493825, 4771.093492236464, 4789.425268967746, 4779.30700048498, 4786.473487916257, 4790.952090479051, 4813.542713442217, 4864.562189402971, 4558.954410455985, 4685.062987402602, 4733.9763301183275, 4740.431148262231, 4804.0, 4767.976160119178, 4801.063792560417, 4801.159797035435, 4824.372831531879, 4835.468098509091, 4698.177818881613, 4701.482836888008, 4703.129920964632, 4706.741129237925, 4747.738874361943], "unit": "score", "name": "dojo.html", "value": 4519.87254658836}, {"lowerIsBetter": false, "replicates": [500.5070006044046, 504.7400588696822, 528.1865926473231, 528.2208742105395, 534.4842227250703, 31498.0, 32133.357332853328, 32171.67828321716, 32230.194245143855, 32253.51619725703, 32486.350272994525, 32993.67006329936, 33046.66953330466, 33059.0, 33172.66827331726, 7435.553866767984, 7636.579988100652, 7696.345810606105, 7708.884366734504, 7711.498752581092, 7619.857021446772, 7754.379649628045, 7766.57283849388, 7770.883436748453, 7776.144624091346, 7691.115521714991, 7698.884516732253, 7797.298243158115, 7804.492707973964, 7805.336546393563, 7620.847583048336, 7694.692212311501, 7702.576358300291, 7704.26809453101, 7773.144954055049, 7413.184549699528, 7685.730999414994, 7734.03324584427, 7764.689412423496, 7769.417293702938, 32814.83592582022, 32872.83563582167, 33057.0, 33120.834395827864, 33186.33627327464, 2195.4201042280074, 2473.258022593233, 2536.4800215955684, 2546.6434699142137, 2888.6678032026375, 23868.88065559661, 25713.742862571322, 26293.21120366392, 26394.0, 26540.73459265402, 3351.882684106069, 3367.1413789483768, 3368.6294507604143, 3369.1240277527772, 3456.1359660084977, 214482.0, 216055.99999999843, 216061.0, 216393.0, 218114.0, 53544.464555353945, 53782.462175378525, 53799.0, 53896.46103538915, 54144.45855541394, 57576.0, 57930.0, 58280.41719582835, 58408.70795645995, 58452.0, 11908.2259653124, 12114.878851211552, 12251.877481225074, 12296.631101066982, 12329.075319350904, 8635.6977505787, 8655.826883462421, 8658.0, 8747.343949203836, 8827.205551500396, 17396.21717022737, 17621.559461013578, 17827.465176044738, 17846.46460606184, 18559.35042273514, 7239.20368759436, 7345.963270183614, 7450.85098298031, 7528.360089392463, 7574.886376704354, 780.6916268074079, 855.7817756472184, 873.9563021849009, 907.3331101640289, 937.1752857485506, 25301.493970120493, 25856.22431327063, 26110.0, 26302.47395052088, 26586.601200982, 929.5166513412987, 930.6324002019164, 934.9065093490733, 993.8409854423257, 997.2697370062936, 13016.349182540835, 13584.660383490294, 13599.52401665937, 13701.931490342484, 13705.109167904055, 255690.0, 258240.0, 259118.0, 259845.0, 260300.0, 44112.558874410846, 44914.77542612331, 44946.0, 45097.54902450999, 45203.32195017077, 1080.0657431322006, 1082.978340433187, 1124.1681155944543, 1124.606387764276, 1134.8014097532898, 23964.52070958606, 25005.374865628506, 25672.614910776727, 25804.225873223833, 26014.60978085368, 39186.804065979486, 39249.41125883057, 39472.21055578815, 39698.40452393159, 39734.2053158941, 243096.0, 243273.0, 243841.0, 244110.0, 245681.0, 29261.561076584294, 29439.11682649524, 29746.55380169256, 29763.851180743957, 30142.0, 38415.61584384232, 39188.41217381799, 39589.60410395859, 39908.201835962536, 40081.0, 32224.677753222168, 33188.1702957428, 33759.324813504085, 34027.4895876567, 34343.48484772781, 32619.510707339883, 33822.49266260959, 33860.0, 33965.49051764275, 34062.148446289044, 33125.0, 33675.15812104717, 33686.49470257899, 33863.661363386054, 33908.66091339055, 29675.0, 29886.701132988394, 30067.3986520264, 30213.244668883453, 30214.848925755232, 23816.285511434686, 23867.641985369886, 24024.75975240295, 24271.514569708153, 24302.635460467754], "unit": "score", "name": "ext.html", "value": 16139.447649288766}, {"lowerIsBetter": false, "replicates": [311.9703628155326, 312.77323940143384, 321.96297425796035, 325.89897131889103, 328.3760854376684, 11316.151288653342, 15026.474073407418, 15380.461683841053, 15441.922790386061, 15572.377104915804, 13774.173549587033, 13854.792178117312, 14765.11409315439, 14810.703785924276, 14919.850801491983, 4775.80896764129, 4935.333729946447, 4935.358403407552, 4965.677230979993, 4973.5772459341, 4751.192297309466, 4869.196582563891, 4871.732054736988, 4968.826091086813, 4976.552110310071, 4875.829345972892, 4880.072786170616, 4884.877878053059, 4941.629377796662, 4959.553640172384, 4860.198067318888, 4870.172070747982, 4876.0, 4877.292792545079, 4888.486708895568, 4194.454720886265, 4319.460067491564, 4322.740635561876, 4340.565943405666, 4350.825966961318, 17689.0, 17761.0, 17894.642107157913, 18031.72952405715, 18417.35539256133, 1945.863789534733, 2034.4303594993426, 2075.8546901716886, 2153.364757396572, 2375.928722138339, 12190.39048047594, 12231.571894983721, 12236.571719989757, 12583.119181657288, 12688.04839637031, 1731.7662115614357, 1739.8869073510182, 1757.9648407031789, 1805.521536792751, 1812.900290484023, 53176.46823531754, 53342.0, 54039.189412158456, 54123.99999999961, 54426.45573544293, 8620.181082797124, 8782.473051616924, 9058.592363343665, 9095.181433671001, 9176.90823091774, 11477.655670329903, 11636.24364416327, 11642.708932276591, 11659.242149260272, 11676.065914726802, 6405.903911441332, 6419.261784894704, 6453.193350831146, 6589.4069533742195, 6603.70283337251, 6197.853397121547, 6227.06594010893, 6303.180586523814, 6339.936600633934, 6364.427201551883, 5457.5633949283965, 5548.750306236229, 5556.166575013699, 5572.804951826748, 5664.376918538957, 1639.942602008924, 1678.538401939452, 1680.3446655804246, 1683.1079527850259, 1705.8379453951854, 784.5136015670207, 819.9549024803574, 831.4470876866936, 833.5748768128299, 938.4650749072963, 14886.553403397915, 15132.773008404884, 15243.23783810805, 15556.299966501534, 15739.370425182864, 788.0346575445034, 803.6504120707511, 815.8939337886155, 836.4897412578322, 848.5545088828414, 8561.272291855263, 8798.076201998825, 8813.823723525622, 8878.200961913459, 9074.909250907538, 367491.0, 371310.0, 371897.0, 374048.0, 384219.0, 64010.039849402296, 64027.35972640214, 65584.67207664027, 65645.34354656488, 66280.33719662837, 886.0297973718767, 891.3493150000536, 909.60432211988, 918.3846822628722, 919.4575200631659, 14127.15237085778, 14147.858521414653, 14202.076865003743, 14264.215468149352, 14416.13503189812, 30153.698463015087, 31515.684843152194, 32153.839230803696, 32548.186295342806, 32827.835860820545, 42213.78893105515, 44612.776936115115, 44748.32877506905, 45373.773131134134, 45601.54398456106, 6931.201371685918, 7052.576845389293, 7118.928810711826, 7150.392216661642, 7257.165425976081, 8038.196180381915, 10729.409882456539, 11148.498317575892, 11162.274452160584, 11316.20786544934, 9354.71935841926, 9392.765180870532, 9606.51967401641, 9607.51962401891, 9954.55204515813, 9339.766505837408, 9606.231501479726, 9707.174890134418, 9809.803803924024, 9888.802223955625, 9606.951965240409, 9851.950740246253, 9975.750606234902, 10106.343087699275, 10160.136388407069, 6562.0, 6750.8649827004165, 6896.965515172593, 6920.7231710731, 7216.675249613675, 9123.77190570241, 9417.811643766949, 9455.905440945502, 9628.566714497725, 9769.853452198366], "unit": "score", "name": "jquery.html", "value": 7614.652243863475}, {"lowerIsBetter": false, "replicates": [1278.10532627161, 1308.0451270572482, 1354.2348573056222, 1609.7665838453431, 1613.088604938209, 5958.0, 6608.867822643544, 6706.832329191767, 6782.389584937355, 6786.185657721074, 6753.966230168855, 6855.622940738257, 6884.380405763481, 6898.206706228785, 6933.549319294242, 1983.4446355020618, 2039.4799326171806, 2040.2757021257462, 2042.121887588344, 2044.3355909329528, 1976.9901150494227, 1982.0684278389206, 2029.3303209940684, 2096.3710886733993, 2096.4025252802953, 2030.4010316956533, 2049.5798361335965, 2054.2091294851516, 2069.037897377719, 2074.367317968019, 2052.8665636733563, 2056.92800751973, 2067.917283308673, 2081.959020489755, 2082.864613800106, 2031.7866624004414, 2042.0402410866868, 2045.8977051147383, 2061.6186005588866, 2062.113291284747, 7000.089988301539, 7051.788446346566, 7059.329363710439, 7070.717171313193, 7076.044733960901, 3936.4882565266616, 3989.860354887565, 3996.2806694794926, 4032.254033003874, 4076.164386300801, 2502.6621406110125, 2611.4515951649987, 2613.6863576370765, 2633.117905501659, 2654.81416300859, 867.9913200867974, 869.0614136732314, 887.7514295997131, 901.5627420700955, 903.8192361527655, 9338.486383248919, 9451.149396554274, 9520.761980950463, 9574.617015319378, 9577.760555986086, 3633.94549081764, 3689.520362352877, 3762.172322089136, 3778.471014058034, 3789.1853251551047, 8105.594720264081, 8144.714934977247, 8215.260626543639, 8227.794305142419, 8240.175982401712, 4054.108096218827, 4055.229506393776, 4060.4315395844014, 4068.816903239361, 4093.038136038029, 3100.085474784944, 3466.913327166841, 3488.4069708149677, 3635.345637785171, 3638.0541059324764, 3189.856456459465, 3250.1224669339617, 3293.4236508610898, 3319.0872510059926, 3320.8007519548905, 1010.5351538292321, 1033.1579762493543, 1034.99482502587, 1041.3283432186197, 1049.41757324684, 788.3496115704567, 825.2325337436242, 1056.9471526423802, 1063.1335461598771, 1066.9466526673634, 6221.720022598994, 6330.335314791972, 6345.1434056401795, 6468.126802881645, 6503.187101612299, 400.5733893403516, 401.51617301152044, 402.9335159698675, 407.5903716764692, 407.6596042304709, 4915.311856340115, 4979.228219625964, 5000.549950504472, 5001.149804533238, 5020.874478138003, 7888.447808653454, 7975.8404831903035, 8129.1464396238725, 8142.47073940192, 8231.95884020588, 8063.395245356504, 8089.069756977905, 8096.0, 8101.87847182281, 8128.309093727099, 6453.128827608213, 6488.059231411513, 6560.212774467094, 6606.405423511907, 6621.668916554153, 6179.721912513858, 6223.159873417212, 6230.7819226326865, 6285.49716022708, 6297.685115744286, 7085.716571337089, 7120.893186602101, 7158.749443769443, 7338.376238019615, 7540.547567145989, 7422.351739769531, 7565.697372105275, 7584.014078169803, 7672.5012874163, 7700.306972372513, 5199.55803756685, 5879.382664820132, 6026.0659597762415, 6138.907916381168, 6198.845028874314, 6454.548181627241, 6513.4463570595135, 6527.608343499215, 6530.640814755234, 6542.182227221598, 5850.561207909339, 5960.761569537343, 6178.258608966953, 6220.595661282002, 6286.214223222098, 5852.209951656642, 5922.1412895130825, 6018.8194354169445, 6042.395760423922, 6065.909011364922, 5852.326982397079, 5876.294844618673, 5882.058870580687, 5905.261842269716, 5940.8811823764145, 5707.086866101404, 5729.427057294237, 5752.827415177551, 5764.481196692318, 5897.351291358033, 5850.0, 5893.32226793907, 5974.103884417372, 5987.401259873977, 6019.939800601938], "unit": "score", "name": "mootools.html", "value": 3839.1696045681233}, {"lowerIsBetter": false, "replicates": [276.87540606726975, 282.8840175528034, 285.1360378054496, 287.90355230997613, 287.92173310950494, 5668.489835914766, 5720.656760594367, 5722.599418040739, 5727.713614319283, 5758.165066065418, 5622.072358060915, 5624.465675760796, 5624.887502249962, 5630.465105814941, 5632.690202038886, 4043.3126368517273, 4177.0, 4259.595338442843, 4261.637760790337, 4266.57334266574, 4249.830006799724, 4253.680973926952, 4258.190943720699, 4260.275753121961, 4264.893377665552, 4242.448481697375, 4287.592678695534, 4291.549387314319, 4292.0, 4306.0526684129445, 4289.0, 4291.163223171498, 4291.291936830419, 4304.354346847967, 4308.46144231971, 3701.38927077032, 3722.609126041754, 3732.6640602345647, 3732.720045996561, 3733.626637336272, 5411.512963833235, 5412.621116521806, 5413.9729301353245, 5417.6478528895495, 5430.239766432703, 4589.219832628428, 4699.107169637792, 4702.224133018048, 4708.387909571768, 4895.853124406273, 5822.708864556797, 5847.736851841635, 5853.1220316952795, 5856.0, 5861.2087368205175, 3833.961660383416, 3842.846286148551, 3845.1925095729653, 3845.4231865220163, 3859.864904728321, 6098.664573448458, 6183.7835675751585, 6189.566730328879, 6189.752409903554, 6196.070589411579, 3966.5636779954184, 3968.761874287552, 3979.801009949491, 3980.343243364812, 3985.442038114666, 4040.4949381327333, 4044.4944381952255, 4045.2314060328445, 4046.2514434829063, 4059.69552283574, 4516.751578663205, 4612.077584483117, 4625.421822272216, 4636.466806317249, 4636.86089417318, 5797.217375654317, 5843.0651095825315, 5846.883062338729, 5849.707514624251, 5888.205092312569, 1406.7186562687502, 1435.4186554445466, 1435.7056803355288, 1436.1813766153193, 1437.6405898525368, 910.8588168833842, 922.9077092290718, 927.758782716485, 945.2485274207022, 948.8244674735196, 5077.1876499759865, 5084.237364395371, 5086.669366491166, 5090.618203634742, 5095.643304968691, 6128.632282063001, 6139.3553676863285, 6143.262808463013, 6145.678679084019, 6147.262328520516, 4910.919597688503, 4995.425526064477, 5052.974735126374, 5083.517065878809, 5105.438401775802, 3319.767616266838, 3358.261182539837, 3366.9899030290817, 3372.51098590703, 3373.578302712161, 5777.508911742549, 5818.389069147678, 5852.239208902815, 5895.380984996514, 5898.439648233411, 6414.743410263537, 6436.710348034349, 6461.418472337512, 6472.676366181766, 6476.870462590816, 5779.884402312015, 5806.767729290866, 5808.94191058084, 5824.213731146326, 5824.767009319579, 6021.879562408815, 6184.907226391518, 6262.0, 6262.342454042442, 6265.373462653698, 6049.153118563317, 6081.817545473643, 6083.452489275809, 6090.147379366804, 6096.390360963868, 5753.482186603226, 5809.128630705428, 5812.534997200299, 5815.883682326415, 5839.532837372915, 3970.3250447424584, 4024.7182697212083, 4028.6575641070835, 4035.071933455263, 4038.1318016626565, 6091.086337049301, 6190.380961903954, 6207.937920620917, 6214.130021796862, 6225.284092329259, 5784.4504772046585, 5957.314908785372, 5977.641341519523, 6005.87988240224, 6015.218021657157, 5950.821475355746, 5971.731272092853, 5972.104184372379, 5980.43185897339, 5991.0, 5822.912656310244, 5839.912401314069, 5859.94140058611, 5860.2967643883, 5872.236609240771, 5997.850053748692, 6001.729922153426, 6010.188624535632, 6015.248093988252, 6025.367336429787, 5637.548996080386, 5804.245448091721, 5816.883662326645, 5863.2670916135485, 5908.084246941731], "unit": "score", "name": "prototype.html", "value": 4360.115605739838}, {"lowerIsBetter": false, "replicates": [655.4854439265177, 658.5906160815855, 661.1108059659759, 675.8817206988775, 678.1929503890367, 10441.164706823454, 10713.196510261723, 10738.946305268482, 10832.729181770459, 10850.620228292011, 10128.341657792256, 10802.891971080306, 11010.779784404307, 11027.669169924915, 11030.558777648905, 579.8608333999852, 681.0, 682.7200847652464, 692.8545005548841, 693.8300116471446, 679.5039621076617, 683.8290427393151, 685.540687739216, 691.3432239372592, 692.7679227458807, 721.3688022979893, 722.072137303565, 724.0840336973732, 724.7789424225609, 724.8115489972593, 712.2485777504704, 715.2632788228134, 715.4169351978121, 716.3695947566108, 717.5049216040941, 535.2292698514127, 535.4377903201662, 536.471575498134, 536.7021303176736, 537.1325309624966, 10863.402512861789, 10895.291806032583, 10956.726081847937, 10963.83554246687, 11021.228514004022, 10111.544980475895, 10478.895211047868, 10550.472476376228, 10632.25574209798, 10902.25563909771, 8731.214190722802, 8762.255208307302, 8810.427322224099, 8940.821183576358, 8945.64217431302, 2944.175630823373, 3097.349556593118, 3111.859966301522, 3112.6264848218357, 3164.6360668523184, 40295.59704402948, 41603.1679366414, 43395.566044339466, 43636.345454818205, 43786.34320485163, 8559.22966932979, 8618.396712230084, 8619.827603447897, 8640.049594544595, 8684.826303473896, 14101.012929094864, 14279.78580321296, 14289.64275893111, 14374.137551746928, 14513.709725805636, 6171.475424588871, 6223.813285601439, 6301.4328710416285, 6342.682865856688, 6370.8088757337355, 3444.431668774674, 3517.9120521986642, 3580.946285805715, 3619.077135330474, 3628.9455658165148, 2481.3424442522746, 2514.0, 2526.7978561715386, 2530.329462692388, 2531.5063562605483, 468.91559519286176, 474.3734152404914, 478.1966296621709, 479.6330806932699, 488.7995921672169, 492.68714366377606, 508.7227461033672, 513.9922901156485, 524.4912434938104, 536.8201652446396, 6660.833479162963, 6751.122354094035, 6779.457643388517, 6811.875693673727, 6931.861362772716, 493.64704236471096, 522.0941666209125, 530.1649901405302, 536.3028063517412, 545.4055079962859, 3280.4751239801517, 3341.615714192899, 3430.2281986552825, 3458.4466485362723, 3531.1525233943667, 50357.748211259444, 51193.23210151851, 51218.74390628023, 51339.48660513422, 51353.48646513487, 45537.54462455399, 45854.54145458503, 46035.0, 46142.30786538205, 46553.76723116363, 40839.0, 41259.58740412618, 41583.960400989614, 41731.79134104371, 41808.58191418108, 6803.25164231944, 6816.113905192294, 6848.726050958106, 6984.057152284579, 6994.790156295319, 30425.543616845323, 31223.063308100795, 32446.675533244364, 33018.834905825315, 33186.33627327392, 36109.63890361168, 40394.0, 40971.38542921799, 41198.38202427026, 41290.38064428976, 9206.815863682556, 9416.435013899189, 9516.095970882756, 9669.9033009669, 9690.903090969283, 10253.74365640865, 10258.230632702427, 10515.684529464128, 10881.292715973437, 11343.319400835977, 9997.100260976547, 10118.392896426238, 10442.321249118782, 10714.624988125379, 10832.620858269922, 8751.343649226206, 9274.072592740942, 9347.252219822534, 9400.81198376015, 9937.850932235877, 9404.200642945427, 9449.149576538144, 9467.479288639192, 9478.95260523693, 9585.185259252763, 8304.855245341481, 8324.0076197297, 8339.0, 8408.159184081544, 8413.747587572383, 7949.523028618301, 7992.960035199787, 8051.275385215359, 8076.415547024895, 8213.876791848246], "unit": "score", "name": "yui.html", "value": 5333.631145039713}], "name": "dromaeo_css", "value": 6061.4693709201165}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [119.0, 110.0, 114.0, 115.0, 114.0, 125.0, 115.0, 114.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [170.0, 134.0, 154.0, 183.0, 141.0, 160.0, 157.0, 134.0, 176.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 155.2}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 163.0, 165.0, 173.0, 161.0, 162.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 75.0, 161.0, 75.0, 78.0, 74.0, 74.0, 152.0, 74.0], "unit": "score", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 149.0, 95.0, 95.0, 94.0, 140.0, 96.0, 95.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 66.0, 68.0, 67.0, 68.0, 75.0, 67.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.0}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 70.0, 70.0, 72.0, 72.0, 71.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.9}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 85.0, 85.0, 84.0, 86.0, 85.0, 84.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 118.0, 123.0, 119.0, 140.0, 120.0, 122.0, 119.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [155.0, 155.0, 151.0, 150.0, 149.0, 139.0, 158.0, 151.0, 152.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 72.0, 71.0, 71.0, 70.0, 71.0, 73.0, 71.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.4}], "name": "kraken", "value": 1566.8000000000002}]} 09:59:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1566.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6061.47"}}} 09:59:39 INFO - Return code: 0 09:59:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:59:39 ERROR - # TBPL SUCCESS # 09:59:39 INFO - Running post-action listener: _resource_record_post_action 09:59:39 INFO - Running post-run listener: _resource_record_post_run 09:59:40 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 10313728; Write bytes: 417484800; Read time: 2668; Write time: 287540 09:59:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98406400; Read time: 0; Write time: 67760 09:59:40 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 10313728; Write bytes: 319078400; Read time: 2668; Write time: 219780 09:59:40 INFO - Running post-run listener: _upload_blobber_files 09:59:40 INFO - Blob upload gear active. 09:59:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:40 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:59:40 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:59:40 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:59:41 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:59:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:59:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:41 INFO - (blobuploader) - INFO - Done attempting. 09:59:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:59:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:59:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:42 INFO - (blobuploader) - INFO - Done attempting. 09:59:42 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:42 INFO - Return code: 0 09:59:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60c979021b5e051dff7db60de5ab8b05feb1b4cd2a9c74d9effae7e674c59354ab76d024c1e2e859214748b8e4ad180e68ec8398f7be2cc7f2a485422a5efb12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1a4d99982bd03f9ecd98771e77ccba87cee3e28c9fef7e2aea6a8fcb9595cb2fec654f9d2e9358e981bc3000cf3f8d5004b83a6f6cb4e258c48960d90e7e348"} 09:59:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:42 INFO - Contents: 09:59:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/60c979021b5e051dff7db60de5ab8b05feb1b4cd2a9c74d9effae7e674c59354ab76d024c1e2e859214748b8e4ad180e68ec8398f7be2cc7f2a485422a5efb12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1a4d99982bd03f9ecd98771e77ccba87cee3e28c9fef7e2aea6a8fcb9595cb2fec654f9d2e9358e981bc3000cf3f8d5004b83a6f6cb4e258c48960d90e7e348"} 09:59:42 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:42 INFO - Copying logs to upload dir... 09:59:42 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.395771 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-01 09:59:42.746376) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 09:59:42.750160) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 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/60c979021b5e051dff7db60de5ab8b05feb1b4cd2a9c74d9effae7e674c59354ab76d024c1e2e859214748b8e4ad180e68ec8398f7be2cc7f2a485422a5efb12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1a4d99982bd03f9ecd98771e77ccba87cee3e28c9fef7e2aea6a8fcb9595cb2fec654f9d2e9358e981bc3000cf3f8d5004b83a6f6cb4e258c48960d90e7e348"} build_url:https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/MRpnH9OjT8uqKkgKYDeaHQ/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/60c979021b5e051dff7db60de5ab8b05feb1b4cd2a9c74d9effae7e674c59354ab76d024c1e2e859214748b8e4ad180e68ec8398f7be2cc7f2a485422a5efb12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1a4d99982bd03f9ecd98771e77ccba87cee3e28c9fef7e2aea6a8fcb9595cb2fec654f9d2e9358e981bc3000cf3f8d5004b83a6f6cb4e258c48960d90e7e348"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 09:59:42.775812) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:59:42.776154) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1456853003.60785-1785437027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 09:59:42.859681) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 09:59:42.860032) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 09:59:42.860348) ========= ========= Total master_lag: 0.26 =========