builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1468843733.12 results: success (0) buildid: 20160718021354 builduid: a63e499af40648b1a871e9f1fa903410 revision: e29236a2cb1019532749ae35f37266cbbba0c04c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.123707) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.124080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.124359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.144770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.145030) ========= 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=745a4373a2a16df560f216e000000264-1468843600.287207-73179421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 05:08:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-07-18 05:08:53 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078191 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.238296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.238582) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=745a4373a2a16df560f216e000000264-1468843600.287207-73179421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020707 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.288967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.289262) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e29236a2cb1019532749ae35f37266cbbba0c04c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e29236a2cb1019532749ae35f37266cbbba0c04c --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=745a4373a2a16df560f216e000000264-1468843600.287207-73179421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 05:08:53,846 truncating revision to first 12 chars 2016-07-18 05:08:53,846 Setting DEBUG logging. 2016-07-18 05:08:53,846 attempt 1/10 2016-07-18 05:08:53,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e29236a2cb10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 05:08:54,151 unpacking tar archive at: mozilla-beta-e29236a2cb10/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679270 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.981943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.982224) ========= script_repo_revision: e29236a2cb1019532749ae35f37266cbbba0c04c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.982610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.982871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:08:53.993119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-18 05:08:53.993419) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=745a4373a2a16df560f216e000000264-1468843600.287207-73179421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:08:54 INFO - MultiFileLogger online at 20160718 05:08:54 in /builds/slave/test 05:08:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:08:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:54 INFO - {'append_to_log': False, 05:08:54 INFO - 'base_work_dir': '/builds/slave/test', 05:08:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:08:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:54 INFO - 'branch': 'Mozilla-Beta', 05:08:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:54 INFO - 'config_files': ('talos/linux_config.py',), 05:08:54 INFO - 'default_actions': ('clobber', 05:08:54 INFO - 'read-buildbot-config', 05:08:54 INFO - 'download-and-extract', 05:08:54 INFO - 'populate-webroot', 05:08:54 INFO - 'create-virtualenv', 05:08:54 INFO - 'install', 05:08:54 INFO - 'run-tests'), 05:08:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:54 INFO - 'download_minidump_stackwalk': True, 05:08:54 INFO - 'download_symbols': 'ondemand', 05:08:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:54 INFO - 'installer_path': 'installer.exe', 05:08:54 INFO - 'log_level': 'info', 05:08:54 INFO - 'log_name': 'talos', 05:08:54 INFO - 'log_to_console': True, 05:08:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:08:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:08:54 INFO - 'opt_config_files': (), 05:08:54 INFO - 'pip_index': False, 05:08:54 INFO - 'sps_profile': False, 05:08:54 INFO - 'sps_profile_interval': 0, 05:08:54 INFO - 'suite': 'dromaeojs-e10s', 05:08:54 INFO - 'system_bits': '32', 05:08:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:54 INFO - 'title': 'talos-linux64-ix-032', 05:08:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:54 INFO - 'use_talos_json': True, 05:08:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:54 INFO - 'work_dir': 'build'} 05:08:54 INFO - ##### 05:08:54 INFO - ##### Running clobber step. 05:08:54 INFO - ##### 05:08:54 INFO - Running pre-action listener: _resource_record_pre_action 05:08:54 INFO - Running main action method: clobber 05:08:54 INFO - rmtree: /builds/slave/test/build 05:08:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:55 INFO - Running post-action listener: _resource_record_post_action 05:08:55 INFO - ##### 05:08:55 INFO - ##### Running read-buildbot-config step. 05:08:55 INFO - ##### 05:08:55 INFO - Running pre-action listener: _resource_record_pre_action 05:08:55 INFO - Running main action method: read_buildbot_config 05:08:55 INFO - Using buildbot properties: 05:08:55 INFO - { 05:08:55 INFO - "project": "", 05:08:55 INFO - "product": "firefox", 05:08:55 INFO - "script_repo_revision": "production", 05:08:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:08:55 INFO - "repository": "", 05:08:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:08:55 INFO - "buildid": "20160718021354", 05:08:55 INFO - "pgo_build": "True", 05:08:55 INFO - "basedir": "/builds/slave/test", 05:08:55 INFO - "buildnumber": 179, 05:08:55 INFO - "slavename": "talos-linux64-ix-032", 05:08:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:08:55 INFO - "platform": "ubuntu64_hw", 05:08:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:08:55 INFO - "branch": "mozilla-beta", 05:08:55 INFO - "repo_path": "releases/mozilla-beta", 05:08:55 INFO - "revision": "e29236a2cb1019532749ae35f37266cbbba0c04c", 05:08:55 INFO - "stage_platform": "linux64-pgo", 05:08:55 INFO - "builduid": "a63e499af40648b1a871e9f1fa903410", 05:08:55 INFO - "slavebuilddir": "test" 05:08:55 INFO - } 05:08:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:08:55 INFO - Running post-action listener: _resource_record_post_action 05:08:55 INFO - ##### 05:08:55 INFO - ##### Running download-and-extract step. 05:08:55 INFO - ##### 05:08:55 INFO - Running pre-action listener: _resource_record_pre_action 05:08:55 INFO - Running main action method: download_and_extract 05:08:55 INFO - mkdir: /builds/slave/test/build/tests 05:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:55 INFO - https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:08:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:08:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:08:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:08:57 INFO - Downloaded 1327 bytes. 05:08:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:08:57 INFO - Using the following test package requirements: 05:08:57 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:08:57 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:08:57 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:08:57 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:08:57 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:08:57 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:08:57 INFO - u'jsshell-linux-x86_64.zip'], 05:08:57 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:08:57 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:08:57 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:08:57 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:08:57 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:08:57 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:08:57 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:08:57 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:08:57 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:08:57 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:08:57 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:08:57 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:57 INFO - https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:08:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:08:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:08:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:08:59 INFO - Downloaded 24200670 bytes. 05:08:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:08:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:00 INFO - Return code: 0 05:09:00 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:00 INFO - https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:09:03 INFO - Downloaded 24200670 bytes. 05:09:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:05 INFO - Return code: 0 05:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:05 INFO - https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:09:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:09:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:09:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:09:06 INFO - Downloaded 10840145 bytes. 05:09:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:09:06 INFO - Return code: 0 05:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:06 INFO - https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:09:09 INFO - Downloaded 56029897 bytes. 05:09:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:09:10 INFO - mkdir: /builds/slave/test/properties 05:09:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:10 INFO - Contents: 05:09:10 INFO - build_url:https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:09:10 INFO - Running post-action listener: _resource_record_post_action 05:09:10 INFO - Running post-action listener: set_extra_try_arguments 05:09:10 INFO - ##### 05:09:10 INFO - ##### Running populate-webroot step. 05:09:10 INFO - ##### 05:09:10 INFO - Running pre-action listener: _resource_record_pre_action 05:09:10 INFO - Running main action method: populate_webroot 05:09:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:10 INFO - '--tppagecycles', 05:09:10 INFO - '7'], 05:09:10 INFO - 'tests': ['tsvgm']}}, 05:09:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:10 INFO - 'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:10 INFO - 'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['damp', 'tps']}, 05:09:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:10 INFO - 'tests': ['damp', 'tps']}, 05:09:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['dromaeo_dom']}, 05:09:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['a11yr', 05:09:10 INFO - 'ts_paint', 05:09:10 INFO - 'tpaint', 05:09:10 INFO - 'sessionrestore', 05:09:10 INFO - 'sessionrestore_no_auto_restore', 05:09:10 INFO - 'tabpaint']}, 05:09:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:10 INFO - 'ts_paint', 05:09:10 INFO - 'tpaint', 05:09:10 INFO - 'sessionrestore', 05:09:10 INFO - 'sessionrestore_no_auto_restore', 05:09:10 INFO - 'tabpaint']}, 05:09:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:10 INFO - 'ts_paint', 05:09:10 INFO - 'tpaint', 05:09:10 INFO - 'sessionrestore', 05:09:10 INFO - 'sessionrestore_no_auto_restore', 05:09:10 INFO - 'tabpaint']}, 05:09:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:10 INFO - 'ts_paint', 05:09:10 INFO - 'tpaint', 05:09:10 INFO - 'sessionrestore', 05:09:10 INFO - 'sessionrestore_no_auto_restore', 05:09:10 INFO - 'tabpaint']}, 05:09:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['a11yr', 05:09:10 INFO - 'ts_paint', 05:09:10 INFO - 'tpaint', 05:09:10 INFO - 'sessionrestore', 05:09:10 INFO - 'sessionrestore_no_auto_restore', 05:09:10 INFO - 'tabpaint']}, 05:09:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['a11yr', 05:09:10 INFO - 'ts_paint', 05:09:10 INFO - 'tpaint', 05:09:10 INFO - 'sessionrestore', 05:09:10 INFO - 'sessionrestore_no_auto_restore', 05:09:10 INFO - 'tabpaint']}, 05:09:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['tsvgx', 05:09:10 INFO - 'tsvgr_opacity', 05:09:10 INFO - 'tart', 05:09:10 INFO - 'tscrollx', 05:09:10 INFO - 'cart']}, 05:09:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:10 INFO - 'tsvgr_opacity', 05:09:10 INFO - 'tart', 05:09:10 INFO - 'tscrollx', 05:09:10 INFO - 'cart']}, 05:09:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:10 INFO - 'talos_options': ['--disable-e10s'], 05:09:10 INFO - 'tests': ['tp5o']}, 05:09:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:10 INFO - 'tests': ['tp5o']}, 05:09:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:10 INFO - 'talos_options': ['--disable-e10s', 05:09:10 INFO - '--xperf_path', 05:09:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:10 INFO - 'tests': ['tp5n']}, 05:09:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:10 INFO - 'talos_options': ['--xperf_path', 05:09:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:10 INFO - 'tests': ['tp5n']}}, 05:09:10 INFO - 'talos.zip': {'path': '', 05:09:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:10 INFO - Running post-action listener: _resource_record_post_action 05:09:10 INFO - ##### 05:09:10 INFO - ##### Running create-virtualenv step. 05:09:10 INFO - ##### 05:09:10 INFO - Running pre-action listener: _resource_record_pre_action 05:09:10 INFO - Running main action method: create_virtualenv 05:09:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:09:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:10 INFO - Using real prefix '/usr' 05:09:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:13 INFO - Installing pip.................done. 05:09:13 INFO - Return code: 0 05:09:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:09:13 INFO - Using env: {'DISPLAY': ':0', 05:09:13 INFO - 'HOME': '/home/cltbld', 05:09:13 INFO - 'LANG': 'en_US.UTF-8', 05:09:13 INFO - 'LANGUAGE': 'en_US:en', 05:09:13 INFO - 'LOGNAME': 'cltbld', 05:09:13 INFO - 'MAIL': '/var/mail/cltbld', 05:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:13 INFO - 'MOZ_NO_REMOTE': '1', 05:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:13 INFO - 'NO_EM_RESTART': '1', 05:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:13 INFO - 'PWD': '/builds/slave/test', 05:09:13 INFO - 'SHELL': '/bin/bash', 05:09:13 INFO - 'SHLVL': '1', 05:09:13 INFO - 'TERM': 'linux', 05:09:13 INFO - 'TMOUT': '86400', 05:09:13 INFO - 'USER': 'cltbld', 05:09:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:13 INFO - '_': '/tools/buildbot/bin/python'} 05:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:09:13 INFO - Cleaning up... 05:09:13 INFO - Return code: 0 05:09:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:09:13 INFO - Using env: {'DISPLAY': ':0', 05:09:13 INFO - 'HOME': '/home/cltbld', 05:09:13 INFO - 'LANG': 'en_US.UTF-8', 05:09:13 INFO - 'LANGUAGE': 'en_US:en', 05:09:13 INFO - 'LOGNAME': 'cltbld', 05:09:13 INFO - 'MAIL': '/var/mail/cltbld', 05:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:13 INFO - 'MOZ_NO_REMOTE': '1', 05:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:13 INFO - 'NO_EM_RESTART': '1', 05:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:13 INFO - 'PWD': '/builds/slave/test', 05:09:13 INFO - 'SHELL': '/bin/bash', 05:09:13 INFO - 'SHLVL': '1', 05:09:13 INFO - 'TERM': 'linux', 05:09:13 INFO - 'TMOUT': '86400', 05:09:13 INFO - 'USER': 'cltbld', 05:09:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:13 INFO - '_': '/tools/buildbot/bin/python'} 05:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:13 INFO - Downloading/unpacking psutil>=0.7.1 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:15 INFO - Installing collected packages: psutil 05:09:15 INFO - Running setup.py install for psutil 05:09:15 INFO - building 'psutil._psutil_linux' extension 05:09:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:09:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:09:16 INFO - building 'psutil._psutil_posix' extension 05:09:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:09:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:09:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:16 INFO - Successfully installed psutil 05:09:16 INFO - Cleaning up... 05:09:16 INFO - Return code: 0 05:09:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:16 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 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:09:16 INFO - Using env: {'DISPLAY': ':0', 05:09:16 INFO - 'HOME': '/home/cltbld', 05:09:16 INFO - 'LANG': 'en_US.UTF-8', 05:09:16 INFO - 'LANGUAGE': 'en_US:en', 05:09:16 INFO - 'LOGNAME': 'cltbld', 05:09:16 INFO - 'MAIL': '/var/mail/cltbld', 05:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:16 INFO - 'MOZ_NO_REMOTE': '1', 05:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:16 INFO - 'NO_EM_RESTART': '1', 05:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:16 INFO - 'PWD': '/builds/slave/test', 05:09:16 INFO - 'SHELL': '/bin/bash', 05:09:16 INFO - 'SHLVL': '1', 05:09:16 INFO - 'TERM': 'linux', 05:09:16 INFO - 'TMOUT': '86400', 05:09:16 INFO - 'USER': 'cltbld', 05:09:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:16 INFO - '_': '/tools/buildbot/bin/python'} 05:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:09:18 INFO - Installing collected packages: mozsystemmonitor 05:09:18 INFO - Running setup.py install for mozsystemmonitor 05:09:18 INFO - Successfully installed mozsystemmonitor 05:09:18 INFO - Cleaning up... 05:09:18 INFO - Return code: 0 05:09:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:09:18 INFO - Using env: {'DISPLAY': ':0', 05:09:18 INFO - 'HOME': '/home/cltbld', 05:09:18 INFO - 'LANG': 'en_US.UTF-8', 05:09:18 INFO - 'LANGUAGE': 'en_US:en', 05:09:18 INFO - 'LOGNAME': 'cltbld', 05:09:18 INFO - 'MAIL': '/var/mail/cltbld', 05:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:18 INFO - 'MOZ_NO_REMOTE': '1', 05:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:18 INFO - 'NO_EM_RESTART': '1', 05:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:18 INFO - 'PWD': '/builds/slave/test', 05:09:18 INFO - 'SHELL': '/bin/bash', 05:09:18 INFO - 'SHLVL': '1', 05:09:18 INFO - 'TERM': 'linux', 05:09:18 INFO - 'TMOUT': '86400', 05:09:18 INFO - 'USER': 'cltbld', 05:09:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:18 INFO - '_': '/tools/buildbot/bin/python'} 05:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - Downloading docopt-0.6.1.tar.gz 05:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:21 INFO - Running setup.py install for blobuploader 05:09:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:21 INFO - Running setup.py install for requests 05:09:22 INFO - Running setup.py install for docopt 05:09:22 INFO - Successfully installed blobuploader requests docopt 05:09:22 INFO - Cleaning up... 05:09:22 INFO - Return code: 0 05:09:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:22 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 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:22 INFO - Using env: {'DISPLAY': ':0', 05:09:22 INFO - 'HOME': '/home/cltbld', 05:09:22 INFO - 'LANG': 'en_US.UTF-8', 05:09:22 INFO - 'LANGUAGE': 'en_US:en', 05:09:22 INFO - 'LOGNAME': 'cltbld', 05:09:22 INFO - 'MAIL': '/var/mail/cltbld', 05:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:22 INFO - 'MOZ_NO_REMOTE': '1', 05:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:22 INFO - 'NO_EM_RESTART': '1', 05:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:22 INFO - 'PWD': '/builds/slave/test', 05:09:22 INFO - 'SHELL': '/bin/bash', 05:09:22 INFO - 'SHLVL': '1', 05:09:22 INFO - 'TERM': 'linux', 05:09:22 INFO - 'TMOUT': '86400', 05:09:22 INFO - 'USER': 'cltbld', 05:09:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:22 INFO - '_': '/tools/buildbot/bin/python'} 05:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:22 INFO - Running setup.py (path:/tmp/pip-P1nb9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:22 INFO - Running setup.py (path:/tmp/pip-HHxl7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:22 INFO - Running setup.py (path:/tmp/pip-Zx5KYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:22 INFO - Running setup.py (path:/tmp/pip-GNWZ38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:22 INFO - Running setup.py (path:/tmp/pip-bhhCzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:22 INFO - Running setup.py (path:/tmp/pip-51nYaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:22 INFO - Running setup.py (path:/tmp/pip-mW5vXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:22 INFO - Running setup.py (path:/tmp/pip-WBR0fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:23 INFO - Running setup.py (path:/tmp/pip-OpHWL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:23 INFO - Running setup.py (path:/tmp/pip-FHALp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:23 INFO - Running setup.py (path:/tmp/pip-nhKVZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:23 INFO - Running setup.py (path:/tmp/pip-YdpSNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:23 INFO - Running setup.py (path:/tmp/pip-NbY6IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:23 INFO - Running setup.py (path:/tmp/pip-Asxvob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:23 INFO - Running setup.py (path:/tmp/pip-3d2paC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:23 INFO - Running setup.py (path:/tmp/pip-cgAsn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:23 INFO - Running setup.py (path:/tmp/pip-AdgSQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:23 INFO - Running setup.py install for manifestparser 05:09:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:23 INFO - Running setup.py install for mozcrash 05:09:23 INFO - Running setup.py install for mozdebug 05:09:23 INFO - Running setup.py install for mozdevice 05:09:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozfile 05:09:24 INFO - Running setup.py install for mozhttpd 05:09:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozinfo 05:09:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozInstall 05:09:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozleak 05:09:24 INFO - Running setup.py install for mozlog 05:09:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for moznetwork 05:09:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozprocess 05:09:24 INFO - Running setup.py install for mozprofile 05:09:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Running setup.py install for mozrunner 05:09:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Running setup.py install for mozscreenshot 05:09:25 INFO - Running setup.py install for moztest 05:09:25 INFO - Running setup.py install for mozversion 05:09:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:25 INFO - Cleaning up... 05:09:25 INFO - Return code: 0 05:09:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 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 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:25 INFO - Using env: {'DISPLAY': ':0', 05:09:25 INFO - 'HOME': '/home/cltbld', 05:09:25 INFO - 'LANG': 'en_US.UTF-8', 05:09:25 INFO - 'LANGUAGE': 'en_US:en', 05:09:25 INFO - 'LOGNAME': 'cltbld', 05:09:25 INFO - 'MAIL': '/var/mail/cltbld', 05:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:25 INFO - 'MOZ_NO_REMOTE': '1', 05:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:25 INFO - 'NO_EM_RESTART': '1', 05:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:25 INFO - 'PWD': '/builds/slave/test', 05:09:25 INFO - 'SHELL': '/bin/bash', 05:09:25 INFO - 'SHLVL': '1', 05:09:25 INFO - 'TERM': 'linux', 05:09:25 INFO - 'TMOUT': '86400', 05:09:25 INFO - 'USER': 'cltbld', 05:09:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:25 INFO - '_': '/tools/buildbot/bin/python'} 05:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:25 INFO - Running setup.py (path:/tmp/pip-rxGZUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:25 INFO - Running setup.py (path:/tmp/pip-tPD7Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:25 INFO - Running setup.py (path:/tmp/pip-fQpV4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:25 INFO - Running setup.py (path:/tmp/pip-VVJJjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:25 INFO - Running setup.py (path:/tmp/pip-Vhb2UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:26 INFO - Running setup.py (path:/tmp/pip-uHcjWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:26 INFO - Running setup.py (path:/tmp/pip-XBePji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:26 INFO - Running setup.py (path:/tmp/pip-8ub85x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:26 INFO - Running setup.py (path:/tmp/pip-xQTzYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:26 INFO - Running setup.py (path:/tmp/pip-ZGNiF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:26 INFO - Running setup.py (path:/tmp/pip-x73WjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:26 INFO - Running setup.py (path:/tmp/pip-OJ9T0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:26 INFO - Running setup.py (path:/tmp/pip-ZJLoUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:26 INFO - Running setup.py (path:/tmp/pip-miCexk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:26 INFO - Running setup.py (path:/tmp/pip-vgPh6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:26 INFO - Running setup.py (path:/tmp/pip-WwTLQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:26 INFO - Running setup.py (path:/tmp/pip-qnwm0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:28 INFO - Downloading blessings-1.6.tar.gz 05:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:28 INFO - Installing collected packages: blessings 05:09:28 INFO - Running setup.py install for blessings 05:09:28 INFO - Successfully installed blessings 05:09:28 INFO - Cleaning up... 05:09:29 INFO - Return code: 0 05:09:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:29 INFO - Reading from file tmpfile_stdout 05:09:29 INFO - Current package versions: 05:09:29 INFO - argparse == 1.2.1 05:09:29 INFO - blessings == 1.6 05:09:29 INFO - blobuploader == 1.2.4 05:09:29 INFO - docopt == 0.6.1 05:09:29 INFO - manifestparser == 1.1 05:09:29 INFO - mozInstall == 1.12 05:09:29 INFO - mozcrash == 0.17 05:09:29 INFO - mozdebug == 0.1 05:09:29 INFO - mozdevice == 0.48 05:09:29 INFO - mozfile == 1.2 05:09:29 INFO - mozhttpd == 0.7 05:09:29 INFO - mozinfo == 0.9 05:09:29 INFO - mozleak == 0.1 05:09:29 INFO - mozlog == 3.1 05:09:29 INFO - moznetwork == 0.27 05:09:29 INFO - mozprocess == 0.22 05:09:29 INFO - mozprofile == 0.28 05:09:29 INFO - mozrunner == 6.11 05:09:29 INFO - mozscreenshot == 0.1 05:09:29 INFO - mozsystemmonitor == 0.0 05:09:29 INFO - moztest == 0.7 05:09:29 INFO - mozversion == 1.4 05:09:29 INFO - psutil == 3.1.1 05:09:29 INFO - requests == 1.2.3 05:09:29 INFO - wsgiref == 0.1.2 05:09:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:29 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 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:29 INFO - Using env: {'DISPLAY': ':0', 05:09:29 INFO - 'HOME': '/home/cltbld', 05:09:29 INFO - 'LANG': 'en_US.UTF-8', 05:09:29 INFO - 'LANGUAGE': 'en_US:en', 05:09:29 INFO - 'LOGNAME': 'cltbld', 05:09:29 INFO - 'MAIL': '/var/mail/cltbld', 05:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:29 INFO - 'MOZ_NO_REMOTE': '1', 05:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:29 INFO - 'NO_EM_RESTART': '1', 05:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:29 INFO - 'PWD': '/builds/slave/test', 05:09:29 INFO - 'SHELL': '/bin/bash', 05:09:29 INFO - 'SHLVL': '1', 05:09:29 INFO - 'TERM': 'linux', 05:09:29 INFO - 'TMOUT': '86400', 05:09:29 INFO - 'USER': 'cltbld', 05:09:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:29 INFO - '_': '/tools/buildbot/bin/python'} 05:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:09:29 INFO - Cleaning up... 05:09:29 INFO - Return code: 0 05:09:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:29 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 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:09:29 INFO - Using env: {'DISPLAY': ':0', 05:09:29 INFO - 'HOME': '/home/cltbld', 05:09:29 INFO - 'LANG': 'en_US.UTF-8', 05:09:29 INFO - 'LANGUAGE': 'en_US:en', 05:09:29 INFO - 'LOGNAME': 'cltbld', 05:09:29 INFO - 'MAIL': '/var/mail/cltbld', 05:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:29 INFO - 'MOZ_NO_REMOTE': '1', 05:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:29 INFO - 'NO_EM_RESTART': '1', 05:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:29 INFO - 'PWD': '/builds/slave/test', 05:09:29 INFO - 'SHELL': '/bin/bash', 05:09:29 INFO - 'SHLVL': '1', 05:09:29 INFO - 'TERM': 'linux', 05:09:29 INFO - 'TMOUT': '86400', 05:09:29 INFO - 'USER': 'cltbld', 05:09:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:29 INFO - '_': '/tools/buildbot/bin/python'} 05:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:29 INFO - Downloading/unpacking jsonschema 05:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:31 INFO - Downloading/unpacking functools32 (from jsonschema) 05:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:31 INFO - warning: no files found matching '*.txt' 05:09:31 INFO - no previously-included directories found matching 'build' 05:09:31 INFO - no previously-included directories found matching 'dist' 05:09:31 INFO - no previously-included directories found matching '.git*' 05:09:31 INFO - Installing collected packages: jsonschema, functools32 05:09:31 INFO - Running setup.py install for functools32 05:09:32 INFO - warning: no files found matching '*.txt' 05:09:32 INFO - no previously-included directories found matching 'build' 05:09:32 INFO - no previously-included directories found matching 'dist' 05:09:32 INFO - no previously-included directories found matching '.git*' 05:09:32 INFO - Successfully installed jsonschema functools32 05:09:32 INFO - Cleaning up... 05:09:32 INFO - Return code: 0 05:09:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:32 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 0x7fb6fd5e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, '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': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:09:32 INFO - Using env: {'DISPLAY': ':0', 05:09:32 INFO - 'HOME': '/home/cltbld', 05:09:32 INFO - 'LANG': 'en_US.UTF-8', 05:09:32 INFO - 'LANGUAGE': 'en_US:en', 05:09:32 INFO - 'LOGNAME': 'cltbld', 05:09:32 INFO - 'MAIL': '/var/mail/cltbld', 05:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:32 INFO - 'MOZ_NO_REMOTE': '1', 05:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:32 INFO - 'NO_EM_RESTART': '1', 05:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:32 INFO - 'PWD': '/builds/slave/test', 05:09:32 INFO - 'SHELL': '/bin/bash', 05:09:32 INFO - 'SHLVL': '1', 05:09:32 INFO - 'TERM': 'linux', 05:09:32 INFO - 'TMOUT': '86400', 05:09:32 INFO - 'USER': 'cltbld', 05:09:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:32 INFO - '_': '/tools/buildbot/bin/python'} 05:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:32 INFO - Downloading/unpacking flake8 05:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:09:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:09:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:09:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:34 INFO - no previously-included directories found matching 'docs/_build' 05:09:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:09:35 INFO - Running setup.py install for pep8 05:09:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:35 INFO - no previously-included directories found matching 'docs/_build' 05:09:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:09:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:09:35 INFO - Cleaning up... 05:09:35 INFO - Return code: 0 05:09:35 INFO - Running post-action listener: _resource_record_post_action 05:09:35 INFO - Running post-action listener: _start_resource_monitoring 05:09:35 INFO - Starting resource monitoring. 05:09:35 INFO - ##### 05:09:35 INFO - ##### Running install step. 05:09:35 INFO - ##### 05:09:35 INFO - Running pre-action listener: _resource_record_pre_action 05:09:35 INFO - Running main action method: install 05:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:35 INFO - Reading from file tmpfile_stdout 05:09:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:35 INFO - Reading from file tmpfile_stdout 05:09:35 INFO - Output received: 05:09:35 INFO - Usage: mozinstall [options] installer 05:09:35 INFO - Options: 05:09:35 INFO - -h, --help show this help message and exit 05:09:35 INFO - -d DEST, --destination=DEST 05:09:35 INFO - Directory to install application into. [default: 05:09:35 INFO - "/builds/slave/test"] 05:09:35 INFO - --app=APP Application being installed. [default: firefox] 05:09:35 INFO - mkdir: /builds/slave/test/build/application 05:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:09:49 INFO - Reading from file tmpfile_stdout 05:09:49 INFO - Output received: 05:09:49 INFO - /builds/slave/test/build/application/firefox/firefox 05:09:49 INFO - Running post-action listener: _resource_record_post_action 05:09:49 INFO - ##### 05:09:49 INFO - ##### Running run-tests step. 05:09:49 INFO - ##### 05:09:49 INFO - Running pre-action listener: _resource_record_pre_action 05:09:49 INFO - Running main action method: run_tests 05:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:49 INFO - Python 2.7.3 05:09:49 INFO - Return code: 0 05:09:49 INFO - grabbing minidump binary from tooltool 05:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:49 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 0x2752640>, '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 0x2753540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27539d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:09:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:09:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:49 INFO - Return code: 0 05:09:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:09:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:09:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:09:50 INFO - Return code: 0 05:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 05:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 05:09:50 INFO - Using env: {'DISPLAY': ':0', 05:09:50 INFO - 'HOME': '/home/cltbld', 05:09:50 INFO - 'LANG': 'en_US.UTF-8', 05:09:50 INFO - 'LANGUAGE': 'en_US:en', 05:09:50 INFO - 'LOGNAME': 'cltbld', 05:09:50 INFO - 'MAIL': '/var/mail/cltbld', 05:09:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:50 INFO - 'MOZ_NO_REMOTE': '1', 05:09:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:50 INFO - 'NO_EM_RESTART': '1', 05:09:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:50 INFO - 'PWD': '/builds/slave/test', 05:09:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:50 INFO - 'SHELL': '/bin/bash', 05:09:50 INFO - 'SHLVL': '1', 05:09:50 INFO - 'TERM': 'linux', 05:09:50 INFO - 'TMOUT': '86400', 05:09:50 INFO - 'USER': 'cltbld', 05:09:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1468843600.287207-73179421', 05:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:50 INFO - '_': '/tools/buildbot/bin/python'} 05:09:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 05:09:50 INFO - mozversion application_buildid: 20160718021354 05:09:50 INFO - mozversion application_changeset: e29236a2cb1019532749ae35f37266cbbba0c04c 05:09:50 INFO - mozversion application_display_name: Firefox 05:09:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:50 INFO - mozversion application_name: Firefox 05:09:50 INFO - mozversion application_remotingname: firefox 05:09:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:09:50 INFO - mozversion application_vendor: Mozilla 05:09:50 INFO - mozversion application_version: 48.0 05:09:50 INFO - mozversion platform_buildid: 20160718021354 05:09:50 INFO - mozversion platform_changeset: e29236a2cb1019532749ae35f37266cbbba0c04c 05:09:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:09:50 INFO - mozversion platform_version: 48.0 05:09:50 INFO - using testdate: 1468843790 05:09:50 INFO - actual date: 1468843790 05:09:50 INFO - starting webserver on 'localhost:58601' 05:09:50 INFO - SUITE-START | Running 2 tests 05:09:50 INFO - TEST-START | dromaeo_css 05:09:50 INFO - operating with platform_type : linux_ 05:09:50 INFO - Initialising browser for dromaeo_css test... 05:09:50 INFO - TEST-INFO | started process 15598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZTZ59N/profile http://localhost:58601/getInfo.html) 05:09:55 INFO - PROCESS | 15598 | 05:09:55 INFO - PROCESS | 15598 | (process:15671): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:09:55 INFO - PROCESS | 15598 | __metrics Screen width/height:1600/1200 05:09:55 INFO - PROCESS | 15598 | colorDepth:24 05:09:55 INFO - PROCESS | 15598 | Browser inner width/height: 1024/697 05:09:55 INFO - PROCESS | 15598 | __metrics 05:09:56 ERROR - PROCESS | 15598 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:09:57 INFO - TEST-INFO | 15598: exit 0 05:09:57 INFO - Browser initialized. 05:09:57 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:57 INFO - TEST-INFO | started process 15721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZTZ59N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:59 INFO - PROCESS | 15721 | 05:09:59 INFO - PROCESS | 15721 | (process:15789): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:10:09 INFO - PROCESS | 15721 | RSS: Main: 150667264 05:10:09 INFO - PROCESS | 15721 | 05:10:58 INFO - PROCESS | 15721 | 1468843858898 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:13:06 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:58601/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58601/tests/dromaeo/cssquery-ext.html) 05:13:07 INFO - PROCESS | 15721 | RSS: Main: 154902528 05:13:07 INFO - PROCESS | 15721 | 05:16:09 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:58601/tests/dromaeo/cssquery-ext.html (next: http://localhost:58601/tests/dromaeo/cssquery-jquery.html) 05:16:09 INFO - PROCESS | 15721 | RSS: Main: 152453120 05:16:09 INFO - PROCESS | 15721 | 05:19:11 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:58601/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58601/tests/dromaeo/cssquery-mootools.html) 05:19:12 INFO - PROCESS | 15721 | RSS: Main: 151896064 05:19:12 INFO - PROCESS | 15721 | 05:22:13 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:58601/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58601/tests/dromaeo/cssquery-prototype.html) 05:22:14 INFO - PROCESS | 15721 | RSS: Main: 153698304 05:22:14 INFO - PROCESS | 15721 | 05:25:16 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:58601/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58601/tests/dromaeo/cssquery-yui.html) 05:25:17 INFO - PROCESS | 15721 | RSS: Main: 151961600 05:25:17 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | Cycle 1(1): loaded http://localhost:58601/tests/dromaeo/cssquery-yui.html (next: http://localhost:58601/tests/dromaeo/cssquery-dojo.html) 05:28:19 INFO - PROCESS | 15721 | RSS: Main: 155975680 05:28:19 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | __start_tp_report 05:28:19 INFO - PROCESS | 15721 | _x_x_mozilla_page_load 05:28:19 INFO - PROCESS | 15721 | _x_x_mozilla_page_load_details 05:28:19 INFO - PROCESS | 15721 | |i|pagename|runs| 05:28:19 INFO - PROCESS | 15721 | |0;dojo.html;3312.0560640217536;3375.1055970167895;3403.098178982569;3412.5904891413034;3415.812130332832;5568.693721845307;5582.162675598657;5606.663600183987;5610.13042978339;5639.351474580424;5539.169124631308;5593.636413633111;5615.719214039292;5657.462541058603;5660.830175094754;5048.6970781753025;5103.540681338679;5107.565856902168;5152.252923326116;5166.17341225404;5081.466446023152;5160.896782064376;5247.868803279929;5251.789928402859;5279.736013199344;5044.82343117991;5070.188769796833;5093.363329583802;5160.2517634942915;5194.11700010999;5043.899122017558;5069.974650126763;5075.847724568269;5088.313077734532;5107.233914912756;4919.360483137205;5007.37407824022;5010.674306170087;5044.924326135111;5081.898362032775;5354.544863686591;5377.489138531833;5411.350637923474;5416.620836541444;5424.945750542483;5936.139259807347;5941.405859414024;5987.820365389045;6014.7594096236535;6018.6689732064715;5840.795572154997;6025.698715064229;6029.879402411927;6052.878942421171;6075.635461872302;5609.4390560943575;5631.211630371751;5636.408177141382;5637.267155269788;5692.6299790513485;6084.300305464928;6118.663473508911;6129.601575897553;6140.232470941132;6146.938530614637;5729.1119876419225;5819.767209311664;5878.412158784087;5888.558358123158;5909.674967876722;5942;5949.077892926603;5953.047512397996;5963.4931030862;5965.164876917235;5876.941230587725;5917.260342457193;5917.733701983421;5926.703664816742;5927.1405646181065;5856.180134781134;5886.087656413263;5946.078357854453;5972.581919265696;6034.758609655652;4535.297028960516;4540.818367265339;4561.429821272341;4567.543245675406;4578.862634120915;4068.8575899843363;4072.0430698785763;4078.4494093297026;4078.836846526165;4105.712600117963;5658.830235092953;5765.740541675635;5780.653160810365;5784;5817.941820581825;5742.425757424224;5795.623284486495;5802.3037235531165;5805.564582656318;5818.069108942549;5647.802326918621;5718.513926316226;5760.53915686744;5761.423857614289;5782.971085144632;5124.410692770304;5151.974240128776;5176.948230517722;5178.922316165261;5209.166533354645;6246;6266.279377871603;6309.274433440121;6314.021326694278;6316.084167795644;5955.67243801595;6017.398260173947;6051.425114614105;6053.213082299273;6060.848478788065;6253.687315634109;6301.842453938688;6307.558470906993;6314.8737025258315;6316.873662526632;5945.672987985702;5945.732442040205;5947.613405128653;5964.642121472725;5979.372165922689;5893.823185304448;5942.405759424023;5973.462388385066;6007.038873780174;6021.157038014594;5683.687397193194;5708.315002199763;5711.571632127524;5719.056355701263;5746.3966283541295;5616.803411880564;5699.857503562444;5714.771409143587;5721.141828725725;5723.513501352265;5588.329400471969;5645.1532270159805;5730.255066841284;5733.140028995684;5817.476427121579;5895.823125306248;5910.7340169693325;5917.467427931507;5927.644341339534;5928.992071347795;5755.971220143872;5758.510526605118;5769.567282453917;5770.451807078321;5775.33583637887 05:28:19 INFO - PROCESS | 15721 | |1;ext.html;602.740821446778;650.8210242183401;661.8775526527593;670.9131207443935;677.7085853083175;39873.80063099684;40683.186336273255;40730;40781.7960910195;40872;44113.338299925446;44958;44994.325085123666;45010.774946125224;45063.0987380253;8920.776980575489;9145.222656074242;9179.082091790835;9179.862302065441;9190;8923.41997770143;9043.457392556435;9065.138811812867;9065.365424420293;9116.954415227914;9047.095290470967;9060.954695226515;9098.909010909872;9130.497822619753;9141.634334626608;9034.367594268404;9099.727008189731;9104.226140778042;9104.81790364189;9108.316876234308;9048.185663290269;9135.680251191243;9136.543172841399;9151.633934642672;9153.816923661556;43670.344944825854;44194;44325.77837110826;44388.77805610983;44485.332720009224;3733.402655575122;4020.4572382728543;4189.853355132555;4201.894952626179;4373.453318335208;33304;33367.6663233367;33748.83125584381;33877.661223387695;34617.13457163566;4610.423697037871;4613;4620.052889157714;4626.074785042972;4646.651501137394;292511;292528;293204;293421.5328923363;293630;62161.689191553756;62167.689161553906;62219.6889015552;62625.68687156535;62668.686656566424;71623;72233.27766722371;72285;72313.27686723066;72467.2753272471;19867.900660496893;19956.800431995784;19961.700574491395;20047.799522004883;20153.294634687714;13668.043236973515;13682.179069255877;13694.178349299074;13754.518591849237;13754.587362379145;20079.29722459707;20531.692024619642;20534.79465205329;20554.69167962482;21285.255016074672;7569.394448444111;7608.467407281548;7719.922800772033;7731.92268077312;7763.990681211407;1155.3414553704476;1161.983264643437;1170.4615876696644;1184.2302503372705;1278.3352656618506;33189.66810331914;33246.50130248048;33535.329293414;33592.99221023373;34053.82973085119;1223.473906220316;1226.5093962415106;1232.2421710648066;1272.497363541396;1294.8057791331375;16613.169341532874;16688.916555417145;16803.579910502336;16879.15604219784;17008.319667213174;529858;558339;576448;587589;587972;57092.143617845766;57886.7105664469;57958;57987.71006144942;58050;1532.0654400815495;1570.1050401271393;1573.3470609697076;1575.220265968353;1590.9602259943595;31266.843665781525;31775.841120794248;33848.32303353969;34252;34363.31273374568;56133.71933140308;56416.43583564276;56554.43445565492;56724.716376417855;57109.42890571041;449666;451099;452309;452773;452802;31567.84216078905;31757.36485270328;31824.363512729153;32261.677383225866;32447.675523244467;50594;51130.48869511257;51326.74336628293;51351.229731554806;51835.2224716622;43042.78478607587;44059.33910991273;44115.77942110397;44220.55779442164;44931.32603010892;42590.870456476434;43144.78427607842;43179;43575.56424435715;43861.78069109634;43515.34726979034;43726.344104837815;44014.11971760611;44447.33329000132;44866;35813.82093089518;37220.81389593035;37456.625433745314;37961.81019094887;38363.80818095891;28939;29802.701972979994;29903;30079.69920300769;30265.848670757387 05:28:19 INFO - PROCESS | 15721 | |2;jquery.html;418.13446166435483;426.1264407963674;427.9144171165767;429.3538224971418;432.1551367077364;15775.13236771977;18689.906550467247;19306.227750889964;19331.806681933194;20252.69620955683;19344.903275483604;19758.506037349038;19927.900360498177;20261.189552417887;20335.898320508375;5150.8712282193055;5257.8948421031555;5397.514223719864;5865.7360418781045;5903.144044113601;5641.943580564182;5755.136729490568;5802.680852553108;5839.503642190398;5884.646921184722;5815.47660710536;5850.736716847752;5864.648121112726;5866.823995280149;5904.084866845646;5706.486416222539;5956.4043595640305;6003.879922401549;6020.337762846083;6024.939750602525;5828.795992140297;5843.444872737083;5844.444777746107;5858.47273745365;5863.70681465925;22601.88699056494;23280.65079023816;23339.299821005396;23990.640140397907;24209;2406.097713357491;2419.9637005444933;2453.435709786759;2558.7057488388887;2999.3401451680597;9959.402435853872;10491.527881245285;10572.629957951434;10579.84130238047;10686.572537098507;2061.9587608247903;2080.3238947342174;2100;2177.575372802304;2198.7691292414224;78662;84251.15748842494;86837;87406;87589;11202.551897924155;11648.534058637559;11741.941290293495;11842.940785296018;11919.165658403828;16649.50051498457;16742.83257167437;16758.832411675972;16791.916040419965;16858.494245172664;8417.284530814826;8768.298536117096;8829.60266787996;8893.244074253631;8915.153060459246;8776.297896168291;8813.559322033872;8839.071897450674;8893.377463577488;8964.372493925493;4532.637389008872;4633.606143477842;4650.6046986005895;4696.38946936896;4782.282657601388;1984.3550845975117;2058.9794102058786;2086.436662101224;2120.279105104272;2168.2844661261747;1026.6150193677372;1038.5222797513077;1043.7338478687886;1081.7079388565044;1091.8034753744403;19755.901220493804;19812;19874.90062549678;19976;20370.59258814845;1090.4929207918196;1092.6667366453307;1093.639099097296;1097.4074000040048;1119.0488085127738;10929.234953553334;11197.888021119847;11273.661790146309;11339.716507087389;11375.488103035383;512170;521125;524026;528678;529919;84713.57643211745;89809.55095224483;93261.53369233246;94981;95854.5207273973;1076.9892301077045;1104.2546281260277;1121.484117306032;1131.660501849442;1135.5230803062734;16653.25060372262;17129.571760705585;17246.568835779206;17405.564860878072;17570.121493925;36788.63211367959;37890.24219515539;38518.80740596279;39246.607533924296;39278.80360598293;59268.70365648144;64674.67662661845;65012.34987650063;65599;66362.33637663754;12195;12746.298953557272;13219.66950826237;13689.988202595414;13914.652133696738;14217.360218790385;14552.272386380428;14573.854261457249;14815.111093334435;14890.702185956437;12412.56556020535;12682.112252142262;12863.22820630765;12924.612261632166;13112.475500979854;6940.687669055005;7616.895550145087;12459.501619935101;12942.611721648365;13150.60548183556;13148.474061037452;13337.3331333431;13462.326883655975;13483.932580337036;13564.72870542564;13747;13770.449182032606;13842;13858.86141138616;14068.929655351658;13338.19970801755;13402.26287554194;13420.664483387993;13432.328383580978;13514.662133446742 05:28:19 INFO - PROCESS | 15721 | |3;mootools.html;1603.534974857291;1608.7426011838104;1808.7648605681259;1939.476341387826;1948.6005368899378;7569.167391586935;8291.792705182374;8308.459950103254;8528.91471085289;8557.486550806956;8278.461899976497;8337.041240257373;8396.370272229591;8435.62039708213;8446.450980686252;2412.2763171048705;2427.745086765891;2432.8297019208662;2438.6220135878966;2440.1337525178483;2349.3891588187107;2353.2234362660365;2399.808015358767;2418.3470462974988;2420.806335493165;2359.2568340972625;2382.797462215714;2393.772591603795;2413.4690368118986;2415.033986405443;2348.3542025942834;2374.5488357212075;2383.285014495653;2387.2599494156866;2430.890609922558;2387.39121524012;2404.9278521644205;2407.1454633604994;2407.6749638798715;2414.396400899775;8698.869516957251;8739.956300218459;8744.693935712283;8749.081346458657;8765.868511972325;5249.973750131225;5405.837824865261;5432.130859062531;5438.428964958662;5446.509814116709;3396.3546926083964;3432;3488.5813702355626;3513.1919658478437;3528.065062758371;1173.559915031863;1176.6528873982195;1185.419144619139;1195.9282443053444;1219.2379762648345;11892.821607675893;11987.22083064598;12013.87986120145;12018.218815776947;12039.277643341427;4604.815807367735;4610.561996610317;4678.906421871611;4692.460367057832;4723.315119307681;10291.948540257401;10307.84538231927;10310.278280520291;10314.329568578018;10321.380717156995;5370.194470829407;5405.21624364465;5411.5129638331955;5412.188171774186;5420.07858664028;4170.061736109412;4817.301491283744;4906.411230652273;4913.729744864067;4953.752312384367;4119.567445418188;4132.090939993197;4160.895977600584;4183.372494125905;4195.49654041517;1350.7501112294258;1390.2006346350888;1391.3321605629355;1397.832260128791;1401.7196560687903;992.5583115513527;1076.494047797534;1085.5874767588266;1091.476091476096;1107.457345900503;6037.698115094316;6041.395860413923;6123.8162855114415;6268.404501572343;6311.905321420182;968.3076600230869;1034.110664828247;1046.56567524478;1048.7483004078965;1058.8941105889348;4219.556946520633;4264.211120942636;4270.7864606769535;4329.935050974238;4440.711353761995;10221.488925553693;10497.737556561147;10541.683749487527;10605.363678179334;10619.30974486656;10403.375797452178;10427.270091093551;10442.164626829986;10482.10902073317;10487.475626218658;7992.880106798402;8116.675332986732;8127.552984585905;8143.75568732939;8161.061477930114;6061.454469097626;6114.6636934969;6161.353057929032;6175.197224360804;6297.244330680348;9167.679131230376;9329.253659707343;9330.720078397659;9346.719598412059;9511.429314241168;9275.118863707938;9472.052794720474;9498.19265362452;9529.094736000068;9557.044295570387;7176.7488137914925;7280.635968201675;7318.121825380988;7685.730999414994;7804.921950780419;7817.570033648204;7823.608819559113;7839.608019598883;7867.252611001945;7877.527348359117;7089.929100708927;7262.564246145248;7288.635568221674;7314.524555903849;7336.449766267445;7082.114735658043;7099.609521476368;7118.85762284741;7167.928320716726;7178.461615378763;6929.480288978246;7113.359797618239;7126.216116227107;7139.607321597362;7139.964300178466;5216.082755733914;5216.66091704038;5300.552161595562;5337.572994160536;5364.195370694427;5085.302490394743;5258.342707161605;5397.9190312144565;5424.457554244544;5425.511703946664 05:28:19 INFO - PROCESS | 15721 | |4;prototype.html;364.147893928208;365.9231561372112;366.60040555794177;367.81425380183003;368.6184798733312;6421.518386121036;6482.254540727812;6566.080748695186;6590.308017658149;6627.768028119023;6438.195225596801;6443.548951573392;6505.625446711952;6506.089147519351;6524.967375163117;4709.882252943678;4866.732329721864;4867.634927380443;4868.805247790084;4879.70721756694;4802.855914322558;4809.639277054217;4821.734804585746;4831.855044348657;4853.053654537367;4786.090642777861;4814.301926220696;4817.22924332107;4821.108095002418;4847.927281090787;4804.183288840905;4830.975845120787;4834.58905992991;4834.613230941533;4839.661223714342;4191.580841915815;4198.307279298912;4198.580141985807;4217.388478670607;4220.282551966173;6113.205283313186;6161.137440758297;6228.5951413158;6238.906416403757;6239.126522286883;5605.075162598167;5631.380548139701;5643.6049476536655;5652.943470565324;5658.688772117532;6774.390304872536;6788.59268443895;6791.728330866759;6798.456123510156;6828.658567071627;4642.953570464286;4644.698094623873;4647.488776234612;4648.1168577970075;4651.674382793206;7126.322999315057;7176.318249766264;7178.35394814464;7178.820529486752;7190.3888169505135;4738.306166715269;4753.809847606126;4811.230203167476;4821.54195351441;4823.27650852375;4833.130036593377;4870.269459581091;4873.951260487421;4876;4884.291777692286;5649.858753531194;5657.32112146545;5659.8019069333195;5664;5667.574931880043;6897.931020689729;6907.171139463196;6908.516403851782;6918.688659010357;6920.757773477904;1700.4473546097568;1713.083500327319;1715.3738885306773;1716.2276975361137;1716.2448522649995;1078.3152698036647;1107.092184408777;1113.5323164270865;1121.4280716834473;1123.3428444359977;6669.899951500732;6708.563943343667;6732.798016059526;6740.9325906740305;6747.7638282660855;7080.92919070813;7083.901995190754;7089;7103;7109.075820143348;6630.303818099127;6798.252192258848;6825.112735344473;6834.043233947252;6837.145356830396;3845.7885765983624;3864.7294689371474;3867.61323867611;3872.8644497442456;3876.9224615508097;7566.281203285679;7567.545947243183;7576.28025337592;7577.886331705029;7578.924210757822;7213.242609525924;7279.526830755984;7303.160136584361;7326.67029983652;7336.2296958819625;7451.5901625411125;7554.697812087455;7556.206598307209;7557.4331925105835;7567.432442566829;7139.643017848983;7162.247963963709;7171.4621403395995;7180.563887222472;7187.02975098355;7052.0479735235085;7061.894071589033;7077.858442831218;7086.255943125898;7109.893351599627;7296.635168241461;7518.962405187939;7558.9244107558225;7560.206178351194;7574.924250757422;4687.507811679725;4712.740799256074;4744.264638980963;4754.928676069792;4768.880777980578;7144.714211431485;7178.24628414009;7182.389496892613;7187.460940429384;7195.568265904062;6868.896966545606;6929.064576282138;6931.376176143969;6935;6950.93049069523;6721.563098398588;6905.930940690529;6933.653317334214;6944.895826562707;6951.826204344729;6765.25582185969;6779.017042528707;6791.796246112624;6816.965915170393;6827.2490026098085;6997.650117494003;6998.930010699828;7002.719891204295;7004.544704594185;7009.7897063088185;6828.00993855898;6838.281980391987;6838.93161068383;6841.589504629738;6843.897341539781 05:28:19 INFO - PROCESS | 15721 | |5;yui.html;940.2665920581949;940.6707652321684;960.745402468346;966.7389804752719;988.6935050134459;15398.461053863117;15772.526824195264;15798.131102789343;15822.129782861937;15891.125988070666;14796.852031479682;14799.33402996865;14801.185934773583;14819.481318153867;14824.55526334209;715.0632671200717;888.6134531478828;909.1181553892746;909.9545022748869;912.7489940266413;897.9012308646044;904.3624244907357;905.8867641544807;906.4289497616526;910.39003867409;916.8212198621271;931.9207867331285;932.6036434515338;933.3093510802025;935.8362286599852;923.5936188077258;925.1719710858778;932.673564252513;934.7382732834817;935.7707361696393;681.2302098628568;684.5276759036299;685.3009929871503;686.354826463128;687.4500399680286;15634.609134771721;15643.296051677702;15690.529284121494;15729.764053539206;15749.44876929302;15005.624859378602;15482.071075735492;15619.06285622855;15711.450099246586;15904.20478976058;12062.095342849321;12065.939670301592;12163;12521.311327876963;12634.873651263553;4082.8571000015154;4124.05146816234;4139.19285739281;4158.008282292279;4191.7694526801015;58268.41731582672;58677.706611467096;59071;59392.70303648454;60753.392466075216;12107.697307567381;12269.141160118885;12271.938640306742;12277.508899643914;12311;22281.22015729474;22347.106115755512;22408.551828963657;22414.215502457337;22478.21326253606;8755.693550725695;8765.780855478537;8914.064023277462;9026.63893444268;9200;4901.975490122527;4915.3855768029;4942.57988071018;5044.672096313728;5064.088464076502;3601.6938560222675;3703.2223233121344;3703.703703703697;3709.2581483703366;3709.870154544578;601.0863487498978;627.8242092214188;636.4399328590811;647.488484097567;659.0674196012588;727.3998950865557;825.9405024305471;845.3026253341018;845.560308639504;874.9168828961239;9969.501524923724;10025.548850301753;10329.74175645615;10407.219458540489;10663.253572249869;784;787.5589669784939;836.2557323981662;842.4692443760514;851.3955091884831;4683.274092515666;4875.211295615009;4895.534924182197;5058.494150584986;5087.440381558025;56931.43068569344;60840.39159608347;61389.07916381258;61491.38508614946;61546;56559.43440565542;59103.408965910654;59450.70274648599;60267.69866150729;60589.697051515344;49726;52983.470165298626;52987.20519192215;53659.73170134125;54027.459725402245;10084.84872726895;10375.94812025935;10526.368417894952;10555.894441055798;10608.681739547827;40275.59724402719;40446.79776601098;41020.589794101674;41223;41418;50326;53305.46694533005;53397;53538.73230633978;54084.64788380322;13033;13250.204987700768;13319.400626971616;13514.86485135136;13832.654183645489;14708.338124784197;14802;14832.18422986746;14870.702585948437;15288.694226115193;14116.717665646835;14243.145411275356;14543.92728036353;15002;15113.924430378218;13592.001549625165;14110.50613228532;14174.858251417767;14455.927720361331;14580.708385832437;13857.237851918242;13955.511557095453;13978.790318145439;14462.52120970165;14507.274636267934;11211;11374.431278435879;11686.626597664641;11704.122190835891;12056.819147712617;11692;11914.948917368136;11923.701907452383;12109.273443593413;12112.515499380279 05:28:19 INFO - PROCESS | 15721 | __end_tp_report 05:28:19 INFO - PROCESS | 15721 | __start_cc_report 05:28:19 INFO - PROCESS | 15721 | _x_x_mozilla_cycle_collect,326 05:28:19 INFO - PROCESS | 15721 | __end_cc_report 05:28:19 INFO - PROCESS | 15721 | __startTimestamp1468844899867__endTimestamp 05:28:19 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | ------- Summary: start ------- 05:28:19 INFO - PROCESS | 15721 | Number of tests: 6 05:28:19 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | [#0] dojo.html Cycles:165 Average:5556.05 Median:5742.43 stddev:615.14 (10.7%) stddev-sans-first:591.30 05:28:19 INFO - PROCESS | 15721 | Values: 3312.1 3375.1 3403.1 3412.6 3415.8 5568.7 5582.2 5606.7 5610.1 5639.4 5539.2 5593.6 5615.7 5657.5 5660.8 5048.7 5103.5 5107.6 5152.3 5166.2 5081.5 5160.9 5247.9 5251.8 5279.7 5044.8 5070.2 5093.4 5160.3 5194.1 5043.9 5070.0 5075.8 5088.3 5107.2 4919.4 5007.4 5010.7 5044.9 5081.9 5354.5 5377.5 5411.4 5416.6 5424.9 5936.1 5941.4 5987.8 6014.8 6018.7 5840.8 6025.7 6029.9 6052.9 6075.6 5609.4 5631.2 5636.4 5637.3 5692.6 6084.3 6118.7 6129.6 6140.2 6146.9 5729.1 5819.8 5878.4 5888.6 5909.7 5942.0 5949.1 5953.0 5963.5 5965.2 5876.9 5917.3 5917.7 5926.7 5927.1 5856.2 5886.1 5946.1 5972.6 6034.8 4535.3 4540.8 4561.4 4567.5 4578.9 4068.9 4072.0 4078.4 4078.8 4105.7 5658.8 5765.7 5780.7 5784.0 5817.9 5742.4 5795.6 5802.3 5805.6 5818.1 5647.8 5718.5 5760.5 5761.4 5783.0 5124.4 5152.0 5176.9 5178.9 5209.2 6246.0 6266.3 6309.3 6314.0 6316.1 5955.7 6017.4 6051.4 6053.2 6060.8 6253.7 6301.8 6307.6 6314.9 6316.9 5945.7 5945.7 5947.6 5964.6 5979.4 5893.8 5942.4 5973.5 6007.0 6021.2 5683.7 5708.3 5711.6 5719.1 5746.4 5616.8 5699.9 5714.8 5721.1 5723.5 5588.3 5645.2 5730.3 5733.1 5817.5 5895.8 5910.7 5917.5 5927.6 5929.0 5756.0 5758.5 5769.6 5770.5 5775.3 05:28:19 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | [#1] ext.html Cycles:180 Average:61424.71 Median:44086.34 stddev:119985.24 (272.2%) stddev-sans-first:120234.93 05:28:19 INFO - PROCESS | 15721 | Values: 602.7 650.8 661.9 670.9 677.7 39873.8 40683.2 40730.0 40781.8 40872.0 44113.3 44958.0 44994.3 45010.8 45063.1 8920.8 9145.2 9179.1 9179.9 9190.0 8923.4 9043.5 9065.1 9065.4 9117.0 9047.1 9061.0 9098.9 9130.5 9141.6 9034.4 9099.7 9104.2 9104.8 9108.3 9048.2 9135.7 9136.5 9151.6 9153.8 43670.3 44194.0 44325.8 44388.8 44485.3 3733.4 4020.5 4189.9 4201.9 4373.5 33304.0 33367.7 33748.8 33877.7 34617.1 4610.4 4613.0 4620.1 4626.1 4646.7 292511.0 292528.0 293204.0 293421.5 293630.0 62161.7 62167.7 62219.7 62625.7 62668.7 71623.0 72233.3 72285.0 72313.3 72467.3 19867.9 19956.8 19961.7 20047.8 20153.3 13668.0 13682.2 13694.2 13754.5 13754.6 20079.3 20531.7 20534.8 20554.7 21285.3 7569.4 7608.5 7719.9 7731.9 7764.0 1155.3 1162.0 1170.5 1184.2 1278.3 33189.7 33246.5 33535.3 33593.0 34053.8 1223.5 1226.5 1232.2 1272.5 1294.8 16613.2 16688.9 16803.6 16879.2 17008.3 529858.0 558339.0 576448.0 587589.0 587972.0 57092.1 57886.7 57958.0 57987.7 58050.0 1532.1 1570.1 1573.3 1575.2 1591.0 31266.8 31775.8 33848.3 34252.0 34363.3 56133.7 56416.4 56554.4 56724.7 57109.4 449666.0 451099.0 452309.0 452773.0 452802.0 31567.8 31757.4 31824.4 32261.7 32447.7 50594.0 51130.5 51326.7 51351.2 51835.2 43042.8 44059.3 44115.8 44220.6 44931.3 42590.9 43144.8 43179.0 43575.6 43861.8 43515.3 43726.3 44014.1 44447.3 44866.0 35813.8 37220.8 37456.6 37961.8 38363.8 28939.0 29802.7 29903.0 30079.7 30265.8 05:28:19 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | [#2] jquery.html Cycles:180 Average:30702.83 Median:2083.38 stddev:86087.20 (4132.1%) stddev-sans-first:86298.67 05:28:19 INFO - PROCESS | 15721 | Values: 418.1 426.1 427.9 429.4 432.2 15775.1 18689.9 19306.2 19331.8 20252.7 19344.9 19758.5 19927.9 20261.2 20335.9 5150.9 5257.9 5397.5 5865.7 5903.1 5641.9 5755.1 5802.7 5839.5 5884.6 5815.5 5850.7 5864.6 5866.8 5904.1 5706.5 5956.4 6003.9 6020.3 6024.9 5828.8 5843.4 5844.4 5858.5 5863.7 22601.9 23280.7 23339.3 23990.6 24209.0 2406.1 2420.0 2453.4 2558.7 2999.3 9959.4 10491.5 10572.6 10579.8 10686.6 2062.0 2080.3 2100.0 2177.6 2198.8 78662.0 84251.2 86837.0 87406.0 87589.0 11202.6 11648.5 11741.9 11842.9 11919.2 16649.5 16742.8 16758.8 16791.9 16858.5 8417.3 8768.3 8829.6 8893.2 8915.2 8776.3 8813.6 8839.1 8893.4 8964.4 4532.6 4633.6 4650.6 4696.4 4782.3 1984.4 2059.0 2086.4 2120.3 2168.3 1026.6 1038.5 1043.7 1081.7 1091.8 19755.9 19812.0 19874.9 19976.0 20370.6 1090.5 1092.7 1093.6 1097.4 1119.0 10929.2 11197.9 11273.7 11339.7 11375.5 512170.0 521125.0 524026.0 528678.0 529919.0 84713.6 89809.6 93261.5 94981.0 95854.5 1077.0 1104.3 1121.5 1131.7 1135.5 16653.3 17129.6 17246.6 17405.6 17570.1 36788.6 37890.2 38518.8 39246.6 39278.8 59268.7 64674.7 65012.3 65599.0 66362.3 12195.0 12746.3 13219.7 13690.0 13914.7 14217.4 14552.3 14573.9 14815.1 14890.7 12412.6 12682.1 12863.2 12924.6 13112.5 6940.7 7616.9 12459.5 12942.6 13150.6 13148.5 13337.3 13462.3 13483.9 13564.7 13747.0 13770.4 13842.0 13858.9 14068.9 13338.2 13402.3 13420.7 13432.3 13514.7 05:28:19 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | [#3] mootools.html Cycles:180 Average:5717.64 Median:4910.07 stddev:3087.03 (62.9%) stddev-sans-first:3080.21 05:28:19 INFO - PROCESS | 15721 | Values: 1603.5 1608.7 1808.8 1939.5 1948.6 7569.2 8291.8 8308.5 8528.9 8557.5 8278.5 8337.0 8396.4 8435.6 8446.5 2412.3 2427.7 2432.8 2438.6 2440.1 2349.4 2353.2 2399.8 2418.3 2420.8 2359.3 2382.8 2393.8 2413.5 2415.0 2348.4 2374.5 2383.3 2387.3 2430.9 2387.4 2404.9 2407.1 2407.7 2414.4 8698.9 8740.0 8744.7 8749.1 8765.9 5250.0 5405.8 5432.1 5438.4 5446.5 3396.4 3432.0 3488.6 3513.2 3528.1 1173.6 1176.7 1185.4 1195.9 1219.2 11892.8 11987.2 12013.9 12018.2 12039.3 4604.8 4610.6 4678.9 4692.5 4723.3 10291.9 10307.8 10310.3 10314.3 10321.4 5370.2 5405.2 5411.5 5412.2 5420.1 4170.1 4817.3 4906.4 4913.7 4953.8 4119.6 4132.1 4160.9 4183.4 4195.5 1350.8 1390.2 1391.3 1397.8 1401.7 992.6 1076.5 1085.6 1091.5 1107.5 6037.7 6041.4 6123.8 6268.4 6311.9 968.3 1034.1 1046.6 1048.7 1058.9 4219.6 4264.2 4270.8 4329.9 4440.7 10221.5 10497.7 10541.7 10605.4 10619.3 10403.4 10427.3 10442.2 10482.1 10487.5 7992.9 8116.7 8127.6 8143.8 8161.1 6061.5 6114.7 6161.4 6175.2 6297.2 9167.7 9329.3 9330.7 9346.7 9511.4 9275.1 9472.1 9498.2 9529.1 9557.0 7176.7 7280.6 7318.1 7685.7 7804.9 7817.6 7823.6 7839.6 7867.3 7877.5 7089.9 7262.6 7288.6 7314.5 7336.4 7082.1 7099.6 7118.9 7167.9 7178.5 6929.5 7113.4 7126.2 7139.6 7140.0 5216.1 5216.7 5300.6 5337.6 5364.2 5085.3 5258.3 5397.9 5424.5 5425.5 05:28:19 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | [#4] prototype.html Cycles:180 Average:5760.42 Median:6650.10 stddev:1785.45 (26.8%) stddev-sans-first:1743.92 05:28:19 INFO - PROCESS | 15721 | Values: 364.1 365.9 366.6 367.8 368.6 6421.5 6482.3 6566.1 6590.3 6627.8 6438.2 6443.5 6505.6 6506.1 6525.0 4709.9 4866.7 4867.6 4868.8 4879.7 4802.9 4809.6 4821.7 4831.9 4853.1 4786.1 4814.3 4817.2 4821.1 4847.9 4804.2 4831.0 4834.6 4834.6 4839.7 4191.6 4198.3 4198.6 4217.4 4220.3 6113.2 6161.1 6228.6 6238.9 6239.1 5605.1 5631.4 5643.6 5652.9 5658.7 6774.4 6788.6 6791.7 6798.5 6828.7 4643.0 4644.7 4647.5 4648.1 4651.7 7126.3 7176.3 7178.4 7178.8 7190.4 4738.3 4753.8 4811.2 4821.5 4823.3 4833.1 4870.3 4874.0 4876.0 4884.3 5649.9 5657.3 5659.8 5664.0 5667.6 6897.9 6907.2 6908.5 6918.7 6920.8 1700.4 1713.1 1715.4 1716.2 1716.2 1078.3 1107.1 1113.5 1121.4 1123.3 6669.9 6708.6 6732.8 6740.9 6747.8 7080.9 7083.9 7089.0 7103.0 7109.1 6630.3 6798.3 6825.1 6834.0 6837.1 3845.8 3864.7 3867.6 3872.9 3876.9 7566.3 7567.5 7576.3 7577.9 7578.9 7213.2 7279.5 7303.2 7326.7 7336.2 7451.6 7554.7 7556.2 7557.4 7567.4 7139.6 7162.2 7171.5 7180.6 7187.0 7052.0 7061.9 7077.9 7086.3 7109.9 7296.6 7519.0 7558.9 7560.2 7574.9 4687.5 4712.7 4744.3 4754.9 4768.9 7144.7 7178.2 7182.4 7187.5 7195.6 6868.9 6929.1 6931.4 6935.0 6950.9 6721.6 6905.9 6933.7 6944.9 6951.8 6765.3 6779.0 6791.8 6817.0 6827.2 6997.7 6998.9 7002.7 7004.5 7009.8 6828.0 6838.3 6838.9 6841.6 6843.9 05:28:19 INFO - PROCESS | 15721 | 05:28:19 INFO - PROCESS | 15721 | [#5] yui.html Cycles:180 Average:16215.40 Median:22778.60 stddev:18223.38 (80.0%) stddev-sans-first:18238.39 05:28:19 INFO - PROCESS | 15721 | Values: 940.3 940.7 960.7 966.7 988.7 15398.5 15772.5 15798.1 15822.1 15891.1 14796.9 14799.3 14801.2 14819.5 14824.6 715.1 888.6 909.1 910.0 912.7 897.9 904.4 905.9 906.4 910.4 916.8 931.9 932.6 933.3 935.8 923.6 925.2 932.7 934.7 935.8 681.2 684.5 685.3 686.4 687.5 15634.6 15643.3 15690.5 15729.8 15749.4 15005.6 15482.1 15619.1 15711.5 15904.2 12062.1 12065.9 12163.0 12521.3 12634.9 4082.9 4124.1 4139.2 4158.0 4191.8 58268.4 58677.7 59071.0 59392.7 60753.4 12107.7 12269.1 12271.9 12277.5 12311.0 22281.2 22347.1 22408.6 22414.2 22478.2 8755.7 8765.8 8914.1 9026.6 9200.0 4902.0 4915.4 4942.6 5044.7 5064.1 3601.7 3703.2 3703.7 3709.3 3709.9 601.1 627.8 636.4 647.5 659.1 727.4 825.9 845.3 845.6 874.9 9969.5 10025.5 10329.7 10407.2 10663.3 784.0 787.6 836.3 842.5 851.4 4683.3 4875.2 4895.5 5058.5 5087.4 56931.4 60840.4 61389.1 61491.4 61546.0 56559.4 59103.4 59450.7 60267.7 60589.7 49726.0 52983.5 52987.2 53659.7 54027.5 10084.8 10375.9 10526.4 10555.9 10608.7 40275.6 40446.8 41020.6 41223.0 41418.0 50326.0 53305.5 53397.0 53538.7 54084.6 13033.0 13250.2 13319.4 13514.9 13832.7 14708.3 14802.0 14832.2 14870.7 15288.7 14116.7 14243.1 14543.9 15002.0 15113.9 13592.0 14110.5 14174.9 14455.9 14580.7 13857.2 13955.5 13978.8 14462.5 14507.3 11211.0 11374.4 11686.6 11704.1 12056.8 11692.0 11914.9 11923.7 12109.3 12112.5 05:28:19 INFO - PROCESS | 15721 | -------- Summary: end -------- 05:28:19 INFO - PROCESS | 15721 | 05:28:20 INFO - TEST-INFO | 15721: exit 0 05:28:20 INFO - TEST-OK | dromaeo_css | took 1109933ms 05:28:20 INFO - TEST-START | kraken 05:28:20 INFO - operating with platform_type : linux_ 05:28:20 INFO - Initialising browser for kraken test... 05:28:20 INFO - TEST-INFO | started process 15966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxiaw7I/profile http://localhost:58601/getInfo.html) 05:28:24 INFO - PROCESS | 15966 | 05:28:24 INFO - PROCESS | 15966 | (process:16041): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:28:25 INFO - PROCESS | 15966 | __metrics Screen width/height:1600/1200 05:28:25 INFO - PROCESS | 15966 | colorDepth:24 05:28:25 INFO - PROCESS | 15966 | Browser inner width/height: 1024/697 05:28:25 INFO - PROCESS | 15966 | __metrics 05:28:25 ERROR - PROCESS | 15966 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:28:26 INFO - TEST-INFO | 15966: exit 0 05:28:26 INFO - Browser initialized. 05:28:26 INFO - Running cycle 1/1 for kraken test... 05:28:26 INFO - TEST-INFO | started process 16091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxiaw7I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:28 INFO - PROCESS | 16091 | 05:28:28 INFO - PROCESS | 16091 | (process:16159): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:28:38 INFO - PROCESS | 16091 | RSS: Main: 150638592 05:28:38 INFO - PROCESS | 16091 | 05:28:41 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58601/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:41 INFO - PROCESS | 16091 | RSS: Main: 155934720 05:28:41 INFO - PROCESS | 16091 | 05:28:44 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58601/tests/kraken/driver.html?testName=audio-dft) 05:28:45 INFO - PROCESS | 16091 | RSS: Main: 155922432 05:28:45 INFO - PROCESS | 16091 | 05:28:47 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58601/tests/kraken/driver.html?testName=audio-fft) 05:28:48 INFO - PROCESS | 16091 | RSS: Main: 156106752 05:28:48 INFO - PROCESS | 16091 | 05:28:50 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58601/tests/kraken/driver.html?testName=audio-oscillator) 05:28:51 INFO - PROCESS | 16091 | RSS: Main: 156012544 05:28:51 INFO - PROCESS | 16091 | 05:28:53 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58601/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:54 INFO - PROCESS | 16091 | RSS: Main: 155799552 05:28:54 INFO - PROCESS | 16091 | 05:28:57 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58601/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:57 INFO - PROCESS | 16091 | RSS: Main: 156131328 05:28:57 INFO - PROCESS | 16091 | 05:29:01 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58601/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:01 INFO - PROCESS | 16091 | RSS: Main: 156520448 05:29:01 INFO - PROCESS | 16091 | 05:29:04 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58601/tests/kraken/driver.html?testName=json-parse-financial) 05:29:05 INFO - PROCESS | 16091 | RSS: Main: 156188672 05:29:05 INFO - PROCESS | 16091 | 05:29:06 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58601/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:07 INFO - PROCESS | 16091 | RSS: Main: 156041216 05:29:07 INFO - PROCESS | 16091 | 05:29:08 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58601/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:09 INFO - PROCESS | 16091 | RSS: Main: 156086272 05:29:09 INFO - PROCESS | 16091 | 05:29:11 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58601/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:12 INFO - PROCESS | 16091 | RSS: Main: 156368896 05:29:12 INFO - PROCESS | 16091 | 05:29:14 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:15 INFO - PROCESS | 16091 | RSS: Main: 156917760 05:29:15 INFO - PROCESS | 16091 | 05:29:18 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:18 INFO - PROCESS | 16091 | RSS: Main: 156737536 05:29:18 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | Cycle 1(1): loaded http://localhost:58601/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58601/tests/kraken/driver.html?testName=ai-astar) 05:29:20 INFO - PROCESS | 16091 | RSS: Main: 157949952 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | __start_tp_report 05:29:20 INFO - PROCESS | 16091 | _x_x_mozilla_page_load 05:29:20 INFO - PROCESS | 16091 | _x_x_mozilla_page_load_details 05:29:20 INFO - PROCESS | 16091 | |i|pagename|runs| 05:29:20 INFO - PROCESS | 16091 | |0;ai-astar;108;110;106;110;112;111;103;110;112;110 05:29:20 INFO - PROCESS | 16091 | |1;audio-beat-detection;164;127;157;183;127;161;164;129;191;134 05:29:20 INFO - PROCESS | 16091 | |2;audio-dft;163;163;163;162;164;165;163;164;163;164 05:29:20 INFO - PROCESS | 16091 | |3;audio-fft;79;77;78;174;77;75;76;76;159;73 05:29:20 INFO - PROCESS | 16091 | |4;audio-oscillator;92;93;154;92;93;92;145;93;92;140 05:29:20 INFO - PROCESS | 16091 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;118;117;117 05:29:20 INFO - PROCESS | 16091 | |6;imaging-darkroom;147;146;146;146;146;146;146;146;146;146 05:29:20 INFO - PROCESS | 16091 | |7;imaging-desaturate;96;95;94;97;97;96;94;95;95;95 05:29:20 INFO - PROCESS | 16091 | |8;json-parse-financial;57;55;55;57;55;58;59;81;56;54 05:29:20 INFO - PROCESS | 16091 | |9;json-stringify-tinderbox;56;57;57;57;57;57;58;57;57;58 05:29:20 INFO - PROCESS | 16091 | |10;stanford-crypto-aes;75;74;72;74;74;74;74;73;74;75 05:29:20 INFO - PROCESS | 16091 | |11;stanford-crypto-ccm;125;119;113;115;125;116;122;112;129;128 05:29:20 INFO - PROCESS | 16091 | |12;stanford-crypto-pbkdf2;164;161;161;163;163;164;165;172;163;164 05:29:20 INFO - PROCESS | 16091 | |13;stanford-crypto-sha256-iterative;68;65;65;67;65;65;65;67;65;66 05:29:20 INFO - PROCESS | 16091 | __end_tp_report 05:29:20 INFO - PROCESS | 16091 | __start_cc_report 05:29:20 INFO - PROCESS | 16091 | _x_x_mozilla_cycle_collect,846 05:29:20 INFO - PROCESS | 16091 | __end_cc_report 05:29:20 INFO - PROCESS | 16091 | __startTimestamp1468844960524__endTimestamp 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | ------- Summary: start ------- 05:29:20 INFO - PROCESS | 16091 | Number of tests: 14 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.82 (2.6%) stddev-sans-first:2.96 05:29:20 INFO - PROCESS | 16091 | Values: 108.0 110.0 106.0 110.0 112.0 111.0 103.0 110.0 112.0 110.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:162.50 stddev:23.45 (14.4%) stddev-sans-first:24.58 05:29:20 INFO - PROCESS | 16091 | Values: 164.0 127.0 157.0 183.0 127.0 161.0 164.0 129.0 191.0 134.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 05:29:20 INFO - PROCESS | 16091 | Values: 163.0 163.0 163.0 162.0 164.0 165.0 163.0 164.0 163.0 164.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.50 stddev:38.20 (49.9%) stddev-sans-first:40.11 05:29:20 INFO - PROCESS | 16091 | Values: 79.0 77.0 78.0 174.0 77.0 75.0 76.0 76.0 159.0 73.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:92.00 stddev:26.26 (28.5%) stddev-sans-first:27.15 05:29:20 INFO - PROCESS | 16091 | Values: 92.0 93.0 154.0 92.0 93.0 92.0 145.0 93.0 92.0 140.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:29:20 INFO - PROCESS | 16091 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.00 05:29:20 INFO - PROCESS | 16091 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:1.07 (1.1%) stddev-sans-first:1.12 05:29:20 INFO - PROCESS | 16091 | Values: 96.0 95.0 94.0 97.0 97.0 96.0 94.0 95.0 95.0 95.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:57.00 stddev:7.99 (14.0%) stddev-sans-first:8.45 05:29:20 INFO - PROCESS | 16091 | Values: 57.0 55.0 55.0 57.0 55.0 58.0 59.0 81.0 56.0 54.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 05:29:20 INFO - PROCESS | 16091 | Values: 56.0 57.0 57.0 57.0 57.0 57.0 58.0 57.0 57.0 58.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:0.88 (1.2%) stddev-sans-first:0.83 05:29:20 INFO - PROCESS | 16091 | Values: 75.0 74.0 72.0 74.0 74.0 74.0 74.0 73.0 74.0 75.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:123.50 stddev:6.26 (5.1%) stddev-sans-first:6.41 05:29:20 INFO - PROCESS | 16091 | Values: 125.0 119.0 113.0 115.0 125.0 116.0 122.0 112.0 129.0 128.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:3.09 (1.9%) stddev-sans-first:3.28 05:29:20 INFO - PROCESS | 16091 | Values: 164.0 161.0 161.0 163.0 163.0 164.0 165.0 172.0 163.0 164.0 05:29:20 INFO - PROCESS | 16091 | 05:29:20 INFO - PROCESS | 16091 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.50 stddev:1.14 (1.7%) stddev-sans-first:0.88 05:29:20 INFO - PROCESS | 16091 | Values: 68.0 65.0 65.0 67.0 65.0 65.0 65.0 67.0 65.0 66.0 05:29:20 INFO - PROCESS | 16091 | -------- Summary: end -------- 05:29:20 INFO - PROCESS | 16091 | 05:29:21 INFO - TEST-INFO | 16091: exit 0 05:29:21 INFO - TEST-OK | kraken | took 60849ms 05:29:21 INFO - SUITE-END | took 1170s 05:29:21 INFO - Completed test suite (00:19:30) 05:29:21 INFO - javascript benchmark 05:29:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.0560640217536, 3375.1055970167895, 3403.098178982569, 3412.5904891413034, 3415.812130332832, 5568.693721845307, 5582.162675598657, 5606.663600183987, 5610.13042978339, 5639.351474580424, 5539.169124631308, 5593.636413633111, 5615.719214039292, 5657.462541058603, 5660.830175094754, 5048.6970781753025, 5103.540681338679, 5107.565856902168, 5152.252923326116, 5166.17341225404, 5081.466446023152, 5160.896782064376, 5247.868803279929, 5251.789928402859, 5279.736013199344, 5044.82343117991, 5070.188769796833, 5093.363329583802, 5160.2517634942915, 5194.11700010999, 5043.899122017558, 5069.974650126763, 5075.847724568269, 5088.313077734532, 5107.233914912756, 4919.360483137205, 5007.37407824022, 5010.674306170087, 5044.924326135111, 5081.898362032775, 5354.544863686591, 5377.489138531833, 5411.350637923474, 5416.620836541444, 5424.945750542483, 5936.139259807347, 5941.405859414024, 5987.820365389045, 6014.7594096236535, 6018.6689732064715, 5840.795572154997, 6025.698715064229, 6029.879402411927, 6052.878942421171, 6075.635461872302, 5609.4390560943575, 5631.211630371751, 5636.408177141382, 5637.267155269788, 5692.6299790513485, 6084.300305464928, 6118.663473508911, 6129.601575897553, 6140.232470941132, 6146.938530614637, 5729.1119876419225, 5819.767209311664, 5878.412158784087, 5888.558358123158, 5909.674967876722, 5942.0, 5949.077892926603, 5953.047512397996, 5963.4931030862, 5965.164876917235, 5876.941230587725, 5917.260342457193, 5917.733701983421, 5926.703664816742, 5927.1405646181065, 5856.180134781134, 5886.087656413263, 5946.078357854453, 5972.581919265696, 6034.758609655652, 4535.297028960516, 4540.818367265339, 4561.429821272341, 4567.543245675406, 4578.862634120915, 4068.8575899843363, 4072.0430698785763, 4078.4494093297026, 4078.836846526165, 4105.712600117963, 5658.830235092953, 5765.740541675635, 5780.653160810365, 5784.0, 5817.941820581825, 5742.425757424224, 5795.623284486495, 5802.3037235531165, 5805.564582656318, 5818.069108942549, 5647.802326918621, 5718.513926316226, 5760.53915686744, 5761.423857614289, 5782.971085144632, 5124.410692770304, 5151.974240128776, 5176.948230517722, 5178.922316165261, 5209.166533354645, 6246.0, 6266.279377871603, 6309.274433440121, 6314.021326694278, 6316.084167795644, 5955.67243801595, 6017.398260173947, 6051.425114614105, 6053.213082299273, 6060.848478788065, 6253.687315634109, 6301.842453938688, 6307.558470906993, 6314.8737025258315, 6316.873662526632, 5945.672987985702, 5945.732442040205, 5947.613405128653, 5964.642121472725, 5979.372165922689, 5893.823185304448, 5942.405759424023, 5973.462388385066, 6007.038873780174, 6021.157038014594, 5683.687397193194, 5708.315002199763, 5711.571632127524, 5719.056355701263, 5746.3966283541295, 5616.803411880564, 5699.857503562444, 5714.771409143587, 5721.141828725725, 5723.513501352265, 5588.329400471969, 5645.1532270159805, 5730.255066841284, 5733.140028995684, 5817.476427121579, 5895.823125306248, 5910.7340169693325, 5917.467427931507, 5927.644341339534, 5928.992071347795, 5755.971220143872, 5758.510526605118, 5769.567282453917, 5770.451807078321, 5775.33583637887], "value": 5516.3322057506675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.740821446778, 650.8210242183401, 661.8775526527593, 670.9131207443935, 677.7085853083175, 39873.80063099684, 40683.186336273255, 40730.0, 40781.7960910195, 40872.0, 44113.338299925446, 44958.0, 44994.325085123666, 45010.774946125224, 45063.0987380253, 8920.776980575489, 9145.222656074242, 9179.082091790835, 9179.862302065441, 9190.0, 8923.41997770143, 9043.457392556435, 9065.138811812867, 9065.365424420293, 9116.954415227914, 9047.095290470967, 9060.954695226515, 9098.909010909872, 9130.497822619753, 9141.634334626608, 9034.367594268404, 9099.727008189731, 9104.226140778042, 9104.81790364189, 9108.316876234308, 9048.185663290269, 9135.680251191243, 9136.543172841399, 9151.633934642672, 9153.816923661556, 43670.344944825854, 44194.0, 44325.77837110826, 44388.77805610983, 44485.332720009224, 3733.402655575122, 4020.4572382728543, 4189.853355132555, 4201.894952626179, 4373.453318335208, 33304.0, 33367.6663233367, 33748.83125584381, 33877.661223387695, 34617.13457163566, 4610.423697037871, 4613.0, 4620.052889157714, 4626.074785042972, 4646.651501137394, 292511.0, 292528.0, 293204.0, 293421.5328923363, 293630.0, 62161.689191553756, 62167.689161553906, 62219.6889015552, 62625.68687156535, 62668.686656566424, 71623.0, 72233.27766722371, 72285.0, 72313.27686723066, 72467.2753272471, 19867.900660496893, 19956.800431995784, 19961.700574491395, 20047.799522004883, 20153.294634687714, 13668.043236973515, 13682.179069255877, 13694.178349299074, 13754.518591849237, 13754.587362379145, 20079.29722459707, 20531.692024619642, 20534.79465205329, 20554.69167962482, 21285.255016074672, 7569.394448444111, 7608.467407281548, 7719.922800772033, 7731.92268077312, 7763.990681211407, 1155.3414553704476, 1161.983264643437, 1170.4615876696644, 1184.2302503372705, 1278.3352656618506, 33189.66810331914, 33246.50130248048, 33535.329293414, 33592.99221023373, 34053.82973085119, 1223.473906220316, 1226.5093962415106, 1232.2421710648066, 1272.497363541396, 1294.8057791331375, 16613.169341532874, 16688.916555417145, 16803.579910502336, 16879.15604219784, 17008.319667213174, 529858.0, 558339.0, 576448.0, 587589.0, 587972.0, 57092.143617845766, 57886.7105664469, 57958.0, 57987.71006144942, 58050.0, 1532.0654400815495, 1570.1050401271393, 1573.3470609697076, 1575.220265968353, 1590.9602259943595, 31266.843665781525, 31775.841120794248, 33848.32303353969, 34252.0, 34363.31273374568, 56133.71933140308, 56416.43583564276, 56554.43445565492, 56724.716376417855, 57109.42890571041, 449666.0, 451099.0, 452309.0, 452773.0, 452802.0, 31567.84216078905, 31757.36485270328, 31824.363512729153, 32261.677383225866, 32447.675523244467, 50594.0, 51130.48869511257, 51326.74336628293, 51351.229731554806, 51835.2224716622, 43042.78478607587, 44059.33910991273, 44115.77942110397, 44220.55779442164, 44931.32603010892, 42590.870456476434, 43144.78427607842, 43179.0, 43575.56424435715, 43861.78069109634, 43515.34726979034, 43726.344104837815, 44014.11971760611, 44447.33329000132, 44866.0, 35813.82093089518, 37220.81389593035, 37456.625433745314, 37961.81019094887, 38363.80818095891, 28939.0, 29802.701972979994, 29903.0, 30079.69920300769, 30265.848670757387], "value": 21309.53679108269, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.13446166435483, 426.1264407963674, 427.9144171165767, 429.3538224971418, 432.1551367077364, 15775.13236771977, 18689.906550467247, 19306.227750889964, 19331.806681933194, 20252.69620955683, 19344.903275483604, 19758.506037349038, 19927.900360498177, 20261.189552417887, 20335.898320508375, 5150.8712282193055, 5257.8948421031555, 5397.514223719864, 5865.7360418781045, 5903.144044113601, 5641.943580564182, 5755.136729490568, 5802.680852553108, 5839.503642190398, 5884.646921184722, 5815.47660710536, 5850.736716847752, 5864.648121112726, 5866.823995280149, 5904.084866845646, 5706.486416222539, 5956.4043595640305, 6003.879922401549, 6020.337762846083, 6024.939750602525, 5828.795992140297, 5843.444872737083, 5844.444777746107, 5858.47273745365, 5863.70681465925, 22601.88699056494, 23280.65079023816, 23339.299821005396, 23990.640140397907, 24209.0, 2406.097713357491, 2419.9637005444933, 2453.435709786759, 2558.7057488388887, 2999.3401451680597, 9959.402435853872, 10491.527881245285, 10572.629957951434, 10579.84130238047, 10686.572537098507, 2061.9587608247903, 2080.3238947342174, 2100.0, 2177.575372802304, 2198.7691292414224, 78662.0, 84251.15748842494, 86837.0, 87406.0, 87589.0, 11202.551897924155, 11648.534058637559, 11741.941290293495, 11842.940785296018, 11919.165658403828, 16649.50051498457, 16742.83257167437, 16758.832411675972, 16791.916040419965, 16858.494245172664, 8417.284530814826, 8768.298536117096, 8829.60266787996, 8893.244074253631, 8915.153060459246, 8776.297896168291, 8813.559322033872, 8839.071897450674, 8893.377463577488, 8964.372493925493, 4532.637389008872, 4633.606143477842, 4650.6046986005895, 4696.38946936896, 4782.282657601388, 1984.3550845975117, 2058.9794102058786, 2086.436662101224, 2120.279105104272, 2168.2844661261747, 1026.6150193677372, 1038.5222797513077, 1043.7338478687886, 1081.7079388565044, 1091.8034753744403, 19755.901220493804, 19812.0, 19874.90062549678, 19976.0, 20370.59258814845, 1090.4929207918196, 1092.6667366453307, 1093.639099097296, 1097.4074000040048, 1119.0488085127738, 10929.234953553334, 11197.888021119847, 11273.661790146309, 11339.716507087389, 11375.488103035383, 512170.0, 521125.0, 524026.0, 528678.0, 529919.0, 84713.57643211745, 89809.55095224483, 93261.53369233246, 94981.0, 95854.5207273973, 1076.9892301077045, 1104.2546281260277, 1121.484117306032, 1131.660501849442, 1135.5230803062734, 16653.25060372262, 17129.571760705585, 17246.568835779206, 17405.564860878072, 17570.121493925, 36788.63211367959, 37890.24219515539, 38518.80740596279, 39246.607533924296, 39278.80360598293, 59268.70365648144, 64674.67662661845, 65012.34987650063, 65599.0, 66362.33637663754, 12195.0, 12746.298953557272, 13219.66950826237, 13689.988202595414, 13914.652133696738, 14217.360218790385, 14552.272386380428, 14573.854261457249, 14815.111093334435, 14890.702185956437, 12412.56556020535, 12682.112252142262, 12863.22820630765, 12924.612261632166, 13112.475500979854, 6940.687669055005, 7616.895550145087, 12459.501619935101, 12942.611721648365, 13150.60548183556, 13148.474061037452, 13337.3331333431, 13462.326883655975, 13483.932580337036, 13564.72870542564, 13747.0, 13770.449182032606, 13842.0, 13858.86141138616, 14068.929655351658, 13338.19970801755, 13402.26287554194, 13420.664483387993, 13432.328383580978, 13514.662133446742], "value": 9887.801085430243, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1603.534974857291, 1608.7426011838104, 1808.7648605681259, 1939.476341387826, 1948.6005368899378, 7569.167391586935, 8291.792705182374, 8308.459950103254, 8528.91471085289, 8557.486550806956, 8278.461899976497, 8337.041240257373, 8396.370272229591, 8435.62039708213, 8446.450980686252, 2412.2763171048705, 2427.745086765891, 2432.8297019208662, 2438.6220135878966, 2440.1337525178483, 2349.3891588187107, 2353.2234362660365, 2399.808015358767, 2418.3470462974988, 2420.806335493165, 2359.2568340972625, 2382.797462215714, 2393.772591603795, 2413.4690368118986, 2415.033986405443, 2348.3542025942834, 2374.5488357212075, 2383.285014495653, 2387.2599494156866, 2430.890609922558, 2387.39121524012, 2404.9278521644205, 2407.1454633604994, 2407.6749638798715, 2414.396400899775, 8698.869516957251, 8739.956300218459, 8744.693935712283, 8749.081346458657, 8765.868511972325, 5249.973750131225, 5405.837824865261, 5432.130859062531, 5438.428964958662, 5446.509814116709, 3396.3546926083964, 3432.0, 3488.5813702355626, 3513.1919658478437, 3528.065062758371, 1173.559915031863, 1176.6528873982195, 1185.419144619139, 1195.9282443053444, 1219.2379762648345, 11892.821607675893, 11987.22083064598, 12013.87986120145, 12018.218815776947, 12039.277643341427, 4604.815807367735, 4610.561996610317, 4678.906421871611, 4692.460367057832, 4723.315119307681, 10291.948540257401, 10307.84538231927, 10310.278280520291, 10314.329568578018, 10321.380717156995, 5370.194470829407, 5405.21624364465, 5411.5129638331955, 5412.188171774186, 5420.07858664028, 4170.061736109412, 4817.301491283744, 4906.411230652273, 4913.729744864067, 4953.752312384367, 4119.567445418188, 4132.090939993197, 4160.895977600584, 4183.372494125905, 4195.49654041517, 1350.7501112294258, 1390.2006346350888, 1391.3321605629355, 1397.832260128791, 1401.7196560687903, 992.5583115513527, 1076.494047797534, 1085.5874767588266, 1091.476091476096, 1107.457345900503, 6037.698115094316, 6041.395860413923, 6123.8162855114415, 6268.404501572343, 6311.905321420182, 968.3076600230869, 1034.110664828247, 1046.56567524478, 1048.7483004078965, 1058.8941105889348, 4219.556946520633, 4264.211120942636, 4270.7864606769535, 4329.935050974238, 4440.711353761995, 10221.488925553693, 10497.737556561147, 10541.683749487527, 10605.363678179334, 10619.30974486656, 10403.375797452178, 10427.270091093551, 10442.164626829986, 10482.10902073317, 10487.475626218658, 7992.880106798402, 8116.675332986732, 8127.552984585905, 8143.75568732939, 8161.061477930114, 6061.454469097626, 6114.6636934969, 6161.353057929032, 6175.197224360804, 6297.244330680348, 9167.679131230376, 9329.253659707343, 9330.720078397659, 9346.719598412059, 9511.429314241168, 9275.118863707938, 9472.052794720474, 9498.19265362452, 9529.094736000068, 9557.044295570387, 7176.7488137914925, 7280.635968201675, 7318.121825380988, 7685.730999414994, 7804.921950780419, 7817.570033648204, 7823.608819559113, 7839.608019598883, 7867.252611001945, 7877.527348359117, 7089.929100708927, 7262.564246145248, 7288.635568221674, 7314.524555903849, 7336.449766267445, 7082.114735658043, 7099.609521476368, 7118.85762284741, 7167.928320716726, 7178.461615378763, 6929.480288978246, 7113.359797618239, 7126.216116227107, 7139.607321597362, 7139.964300178466, 5216.082755733914, 5216.66091704038, 5300.552161595562, 5337.572994160536, 5364.195370694427, 5085.302490394743, 5258.342707161605, 5397.9190312144565, 5424.457554244544, 5425.511703946664], "value": 4684.947804538046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.147893928208, 365.9231561372112, 366.60040555794177, 367.81425380183003, 368.6184798733312, 6421.518386121036, 6482.254540727812, 6566.080748695186, 6590.308017658149, 6627.768028119023, 6438.195225596801, 6443.548951573392, 6505.625446711952, 6506.089147519351, 6524.967375163117, 4709.882252943678, 4866.732329721864, 4867.634927380443, 4868.805247790084, 4879.70721756694, 4802.855914322558, 4809.639277054217, 4821.734804585746, 4831.855044348657, 4853.053654537367, 4786.090642777861, 4814.301926220696, 4817.22924332107, 4821.108095002418, 4847.927281090787, 4804.183288840905, 4830.975845120787, 4834.58905992991, 4834.613230941533, 4839.661223714342, 4191.580841915815, 4198.307279298912, 4198.580141985807, 4217.388478670607, 4220.282551966173, 6113.205283313186, 6161.137440758297, 6228.5951413158, 6238.906416403757, 6239.126522286883, 5605.075162598167, 5631.380548139701, 5643.6049476536655, 5652.943470565324, 5658.688772117532, 6774.390304872536, 6788.59268443895, 6791.728330866759, 6798.456123510156, 6828.658567071627, 4642.953570464286, 4644.698094623873, 4647.488776234612, 4648.1168577970075, 4651.674382793206, 7126.322999315057, 7176.318249766264, 7178.35394814464, 7178.820529486752, 7190.3888169505135, 4738.306166715269, 4753.809847606126, 4811.230203167476, 4821.54195351441, 4823.27650852375, 4833.130036593377, 4870.269459581091, 4873.951260487421, 4876.0, 4884.291777692286, 5649.858753531194, 5657.32112146545, 5659.8019069333195, 5664.0, 5667.574931880043, 6897.931020689729, 6907.171139463196, 6908.516403851782, 6918.688659010357, 6920.757773477904, 1700.4473546097568, 1713.083500327319, 1715.3738885306773, 1716.2276975361137, 1716.2448522649995, 1078.3152698036647, 1107.092184408777, 1113.5323164270865, 1121.4280716834473, 1123.3428444359977, 6669.899951500732, 6708.563943343667, 6732.798016059526, 6740.9325906740305, 6747.7638282660855, 7080.92919070813, 7083.901995190754, 7089.0, 7103.0, 7109.075820143348, 6630.303818099127, 6798.252192258848, 6825.112735344473, 6834.043233947252, 6837.145356830396, 3845.7885765983624, 3864.7294689371474, 3867.61323867611, 3872.8644497442456, 3876.9224615508097, 7566.281203285679, 7567.545947243183, 7576.28025337592, 7577.886331705029, 7578.924210757822, 7213.242609525924, 7279.526830755984, 7303.160136584361, 7326.67029983652, 7336.2296958819625, 7451.5901625411125, 7554.697812087455, 7556.206598307209, 7557.4331925105835, 7567.432442566829, 7139.643017848983, 7162.247963963709, 7171.4621403395995, 7180.563887222472, 7187.02975098355, 7052.0479735235085, 7061.894071589033, 7077.858442831218, 7086.255943125898, 7109.893351599627, 7296.635168241461, 7518.962405187939, 7558.9244107558225, 7560.206178351194, 7574.924250757422, 4687.507811679725, 4712.740799256074, 4744.264638980963, 4754.928676069792, 4768.880777980578, 7144.714211431485, 7178.24628414009, 7182.389496892613, 7187.460940429384, 7195.568265904062, 6868.896966545606, 6929.064576282138, 6931.376176143969, 6935.0, 6950.93049069523, 6721.563098398588, 6905.930940690529, 6933.653317334214, 6944.895826562707, 6951.826204344729, 6765.25582185969, 6779.017042528707, 6791.796246112624, 6816.965915170393, 6827.2490026098085, 6997.650117494003, 6998.930010699828, 7002.719891204295, 7004.544704594185, 7009.7897063088185, 6828.00993855898, 6838.281980391987, 6838.93161068383, 6841.589504629738, 6843.897341539781], "value": 5177.006392238839, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [940.2665920581949, 940.6707652321684, 960.745402468346, 966.7389804752719, 988.6935050134459, 15398.461053863117, 15772.526824195264, 15798.131102789343, 15822.129782861937, 15891.125988070666, 14796.852031479682, 14799.33402996865, 14801.185934773583, 14819.481318153867, 14824.55526334209, 715.0632671200717, 888.6134531478828, 909.1181553892746, 909.9545022748869, 912.7489940266413, 897.9012308646044, 904.3624244907357, 905.8867641544807, 906.4289497616526, 910.39003867409, 916.8212198621271, 931.9207867331285, 932.6036434515338, 933.3093510802025, 935.8362286599852, 923.5936188077258, 925.1719710858778, 932.673564252513, 934.7382732834817, 935.7707361696393, 681.2302098628568, 684.5276759036299, 685.3009929871503, 686.354826463128, 687.4500399680286, 15634.609134771721, 15643.296051677702, 15690.529284121494, 15729.764053539206, 15749.44876929302, 15005.624859378602, 15482.071075735492, 15619.06285622855, 15711.450099246586, 15904.20478976058, 12062.095342849321, 12065.939670301592, 12163.0, 12521.311327876963, 12634.873651263553, 4082.8571000015154, 4124.05146816234, 4139.19285739281, 4158.008282292279, 4191.7694526801015, 58268.41731582672, 58677.706611467096, 59071.0, 59392.70303648454, 60753.392466075216, 12107.697307567381, 12269.141160118885, 12271.938640306742, 12277.508899643914, 12311.0, 22281.22015729474, 22347.106115755512, 22408.551828963657, 22414.215502457337, 22478.21326253606, 8755.693550725695, 8765.780855478537, 8914.064023277462, 9026.63893444268, 9200.0, 4901.975490122527, 4915.3855768029, 4942.57988071018, 5044.672096313728, 5064.088464076502, 3601.6938560222675, 3703.2223233121344, 3703.703703703697, 3709.2581483703366, 3709.870154544578, 601.0863487498978, 627.8242092214188, 636.4399328590811, 647.488484097567, 659.0674196012588, 727.3998950865557, 825.9405024305471, 845.3026253341018, 845.560308639504, 874.9168828961239, 9969.501524923724, 10025.548850301753, 10329.74175645615, 10407.219458540489, 10663.253572249869, 784.0, 787.5589669784939, 836.2557323981662, 842.4692443760514, 851.3955091884831, 4683.274092515666, 4875.211295615009, 4895.534924182197, 5058.494150584986, 5087.440381558025, 56931.43068569344, 60840.39159608347, 61389.07916381258, 61491.38508614946, 61546.0, 56559.43440565542, 59103.408965910654, 59450.70274648599, 60267.69866150729, 60589.697051515344, 49726.0, 52983.470165298626, 52987.20519192215, 53659.73170134125, 54027.459725402245, 10084.84872726895, 10375.94812025935, 10526.368417894952, 10555.894441055798, 10608.681739547827, 40275.59724402719, 40446.79776601098, 41020.589794101674, 41223.0, 41418.0, 50326.0, 53305.46694533005, 53397.0, 53538.73230633978, 54084.64788380322, 13033.0, 13250.204987700768, 13319.400626971616, 13514.86485135136, 13832.654183645489, 14708.338124784197, 14802.0, 14832.18422986746, 14870.702585948437, 15288.694226115193, 14116.717665646835, 14243.145411275356, 14543.92728036353, 15002.0, 15113.924430378218, 13592.001549625165, 14110.50613228532, 14174.858251417767, 14455.927720361331, 14580.708385832437, 13857.237851918242, 13955.511557095453, 13978.790318145439, 14462.52120970165, 14507.274636267934, 11211.0, 11374.431278435879, 11686.626597664641, 11704.122190835891, 12056.819147712617, 11692.0, 11914.948917368136, 11923.701907452383, 12109.273443593413, 12112.515499380279], "value": 7457.3040283718565, "unit": "score"}], "name": "dromaeo_css", "value": 7711.192822872966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 106.0, 110.0, 112.0, 111.0, 103.0, 110.0, 112.0, 110.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 127.0, 157.0, 183.0, 127.0, 161.0, 164.0, 129.0, 191.0, 134.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 164.0, 165.0, 163.0, 164.0, 163.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 174.0, 77.0, 75.0, 76.0, 76.0, 159.0, 73.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 154.0, 92.0, 93.0, 92.0, 145.0, 93.0, 92.0, 140.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 97.0, 97.0, 96.0, 94.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 57.0, 55.0, 58.0, 59.0, 81.0, 56.0, 54.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 57.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 72.0, 74.0, 74.0, 74.0, 74.0, 73.0, 74.0, 75.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 119.0, 113.0, 115.0, 125.0, 116.0, 122.0, 112.0, 129.0, 128.0], "value": 120.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 161.0, 163.0, 163.0, 164.0, 165.0, 172.0, 163.0, 164.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 67.0, 65.0, 66.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1527.9, "alertThreshold": 2.0}]} 05:29:21 INFO - Return code: 0 05:29:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:29:21 ERROR - # TBPL SUCCESS # 05:29:21 INFO - Running post-action listener: _resource_record_post_action 05:29:21 INFO - Running post-run listener: _resource_record_post_run 05:29:22 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 461459456; Read time: 0; Write time: 870900 05:29:22 INFO - install - Wall time: 14s; CPU: 18.0%; Read bytes: 0; Write bytes: 242561024; Read time: 0; Write time: 657908 05:29:22 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 218898432; Read time: 0; Write time: 212992 05:29:22 INFO - Running post-run listener: _upload_blobber_files 05:29:22 INFO - Blob upload gear active. 05:29:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:29:22 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:22 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:24 INFO - (blobuploader) - INFO - Done attempting. 05:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:24 INFO - (blobuploader) - INFO - Done attempting. 05:29:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:25 INFO - Return code: 0 05:29:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2cfff43682c8494e62cc5402a1fade68147aa6d1986ab65d3e31795fa254f0f4b1d6f07f5f955ff8ba93fed103f965c2b07a831df0bc376a6d938bc36ec0f7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d4c4ee58b0ed858671e30e38169cf1184931ea7d7e1171397d7f082e520b46e8b092ac69ed8dad29bf9351e0924b1d6fc16868bfaedd81aba2f234a265085a5"} 05:29:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:25 INFO - Contents: 05:29:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2cfff43682c8494e62cc5402a1fade68147aa6d1986ab65d3e31795fa254f0f4b1d6f07f5f955ff8ba93fed103f965c2b07a831df0bc376a6d938bc36ec0f7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d4c4ee58b0ed858671e30e38169cf1184931ea7d7e1171397d7f082e520b46e8b092ac69ed8dad29bf9351e0924b1d6fc16868bfaedd81aba2f234a265085a5"} 05:29:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:25 INFO - Copying logs to upload dir... 05:29:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.528720 ========= master_lag: 0.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-18 05:29:25.316097) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:29:25.324752) ========= 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=745a4373a2a16df560f216e000000264-1468843600.287207-73179421 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/Mozilla-Beta/sha512/f2cfff43682c8494e62cc5402a1fade68147aa6d1986ab65d3e31795fa254f0f4b1d6f07f5f955ff8ba93fed103f965c2b07a831df0bc376a6d938bc36ec0f7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d4c4ee58b0ed858671e30e38169cf1184931ea7d7e1171397d7f082e520b46e8b092ac69ed8dad29bf9351e0924b1d6fc16868bfaedd81aba2f234a265085a5"} build_url:https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/JcPe8gFpQsGX4dyKBHjUYA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2cfff43682c8494e62cc5402a1fade68147aa6d1986ab65d3e31795fa254f0f4b1d6f07f5f955ff8ba93fed103f965c2b07a831df0bc376a6d938bc36ec0f7f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d4c4ee58b0ed858671e30e38169cf1184931ea7d7e1171397d7f082e520b46e8b092ac69ed8dad29bf9351e0924b1d6fc16868bfaedd81aba2f234a265085a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:29:25.349632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:29:25.349985) ========= 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=745a4373a2a16df560f216e000000264-1468843600.287207-73179421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:29:25.404105) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:29:25.406447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:29:25.406739) ========= ========= Total master_lag: 0.92 =========