builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1460970493.55 results: success (0) buildid: 20160417233026 builduid: 9815e164ec184bc98272d3180d045df5 revision: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.547823) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.548340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.548632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.570520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.570879) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 02:08:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-04-18 02:08:15 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076271 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.660015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.660318) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016296 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:13.709644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 02:08:13.709963) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 --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=337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 02:08:15,229 truncating revision to first 12 chars 2016-04-18 02:08:15,229 Setting DEBUG logging. 2016-04-18 02:08:15,229 attempt 1/10 2016-04-18 02:08:15,229 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4d5b0cdb72fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 02:08:15,542 unpacking tar archive at: fx-team-4d5b0cdb72fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617356 ========= master_lag: 0.84 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 02:08:15.164061) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:15.164379) ========= script_repo_revision: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:15.164763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:15.165025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 02:08:15.228992) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-18 02:08:15.229275) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:08:16 INFO - MultiFileLogger online at 20160418 02:08:16 in /builds/slave/test 02:08:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:08:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:08:16 INFO - {'append_to_log': False, 02:08:16 INFO - 'base_work_dir': '/builds/slave/test', 02:08:16 INFO - 'blob_upload_branch': 'Fx-Team', 02:08:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:08:16 INFO - 'branch': 'Fx-Team', 02:08:16 INFO - 'buildbot_json_path': 'buildprops.json', 02:08:16 INFO - 'config_files': ('talos/linux_config.py',), 02:08:16 INFO - 'default_actions': ('clobber', 02:08:16 INFO - 'read-buildbot-config', 02:08:16 INFO - 'download-and-extract', 02:08:16 INFO - 'populate-webroot', 02:08:16 INFO - 'create-virtualenv', 02:08:16 INFO - 'install', 02:08:16 INFO - 'run-tests'), 02:08:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:08:16 INFO - 'download_minidump_stackwalk': True, 02:08:16 INFO - 'download_symbols': 'ondemand', 02:08:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:08:16 INFO - 'tooltool.py': '/tools/tooltool.py', 02:08:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:08:16 INFO - '/tools/misc-python/virtualenv.py')}, 02:08:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:08:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:08:16 INFO - 'installer_path': 'installer.exe', 02:08:16 INFO - 'log_level': 'info', 02:08:16 INFO - 'log_name': 'talos', 02:08:16 INFO - 'log_to_console': True, 02:08:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:08:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:08:16 INFO - 'opt_config_files': (), 02:08:16 INFO - 'pip_index': False, 02:08:16 INFO - 'sps_profile': False, 02:08:16 INFO - 'sps_profile_interval': 0, 02:08:16 INFO - 'suite': 'dromaeojs-e10s', 02:08:16 INFO - 'system_bits': '32', 02:08:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:08:16 INFO - 'title': 'talos-linux64-ix-060', 02:08:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:08:16 INFO - 'use_talos_json': True, 02:08:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:08:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:08:16 INFO - 'work_dir': 'build'} 02:08:16 INFO - ##### 02:08:16 INFO - ##### Running clobber step. 02:08:16 INFO - ##### 02:08:16 INFO - Running pre-action listener: _resource_record_pre_action 02:08:16 INFO - Running main action method: clobber 02:08:16 INFO - rmtree: /builds/slave/test/build 02:08:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:08:17 INFO - Running post-action listener: _resource_record_post_action 02:08:17 INFO - ##### 02:08:17 INFO - ##### Running read-buildbot-config step. 02:08:17 INFO - ##### 02:08:17 INFO - Running pre-action listener: _resource_record_pre_action 02:08:17 INFO - Running main action method: read_buildbot_config 02:08:17 INFO - Using buildbot properties: 02:08:17 INFO - { 02:08:17 INFO - "project": "", 02:08:17 INFO - "product": "firefox", 02:08:17 INFO - "script_repo_revision": "production", 02:08:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:08:17 INFO - "repository": "", 02:08:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:08:17 INFO - "buildid": "20160417233026", 02:08:17 INFO - "pgo_build": "True", 02:08:17 INFO - "basedir": "/builds/slave/test", 02:08:17 INFO - "buildnumber": 285, 02:08:17 INFO - "slavename": "talos-linux64-ix-060", 02:08:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:08:17 INFO - "platform": "ubuntu64_hw", 02:08:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:08:17 INFO - "branch": "fx-team", 02:08:17 INFO - "repo_path": "integration/fx-team", 02:08:17 INFO - "revision": "4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8", 02:08:17 INFO - "stage_platform": "linux64-pgo", 02:08:17 INFO - "builduid": "9815e164ec184bc98272d3180d045df5", 02:08:17 INFO - "slavebuilddir": "test" 02:08:17 INFO - } 02:08:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:08:17 INFO - Running post-action listener: _resource_record_post_action 02:08:17 INFO - ##### 02:08:17 INFO - ##### Running download-and-extract step. 02:08:17 INFO - ##### 02:08:17 INFO - Running pre-action listener: _resource_record_pre_action 02:08:17 INFO - Running main action method: download_and_extract 02:08:17 INFO - mkdir: /builds/slave/test/build/tests 02:08:17 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')]} 02:08:17 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:08:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:08:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:08:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:08:27 INFO - Downloaded 1361 bytes. 02:08:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:08:27 INFO - Using the following test package requirements: 02:08:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:08:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:08:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:08:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:27 INFO - u'jsshell-linux-x86_64.zip'], 02:08:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:08:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:08:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:08:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:08:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:08:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:08:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:08:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:27 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:08:42 INFO - Downloaded 23774918 bytes. 02:08:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:08:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:08:43 INFO - Return code: 0 02:08:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:43 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:08:45 INFO - Downloaded 23774918 bytes. 02:08:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:08:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:08:47 INFO - Return code: 0 02:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:47 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:08:48 INFO - Downloaded 10841076 bytes. 02:08:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:08:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:08:48 INFO - Return code: 0 02:08:48 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')]} 02:08:48 INFO - https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:08:49 INFO - Downloaded 58250750 bytes. 02:08:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:49 INFO - mkdir: /builds/slave/test/properties 02:08:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:08:49 INFO - Writing to file /builds/slave/test/properties/build_url 02:08:49 INFO - Contents: 02:08:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:08:50 INFO - Running post-action listener: _resource_record_post_action 02:08:50 INFO - Running post-action listener: set_extra_try_arguments 02:08:50 INFO - ##### 02:08:50 INFO - ##### Running populate-webroot step. 02:08:50 INFO - ##### 02:08:50 INFO - Running pre-action listener: _resource_record_pre_action 02:08:50 INFO - Running main action method: populate_webroot 02:08:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:08:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:08:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:08:50 INFO - '--tppagecycles', 02:08:50 INFO - '7'], 02:08:50 INFO - 'tests': ['tsvgm']}}, 02:08:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:08:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:08:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:08:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:08:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['damp', 'tps']}, 02:08:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'tests': ['damp', 'tps']}, 02:08:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['dromaeo_dom']}, 02:08:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:08:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore', 02:08:50 INFO - 'tabpaint']}, 02:08:50 INFO - 'other-e10s': {'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore', 02:08:50 INFO - 'tabpaint']}, 02:08:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore', 02:08:50 INFO - 'tabpaint']}, 02:08:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore', 02:08:50 INFO - 'tabpaint']}, 02:08:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore', 02:08:50 INFO - 'tabpaint']}, 02:08:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['a11yr', 02:08:50 INFO - 'ts_paint', 02:08:50 INFO - 'tpaint', 02:08:50 INFO - 'sessionrestore', 02:08:50 INFO - 'sessionrestore_no_auto_restore', 02:08:50 INFO - 'tabpaint']}, 02:08:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['tsvgx', 02:08:50 INFO - 'tsvgr_opacity', 02:08:50 INFO - 'tart', 02:08:50 INFO - 'tscrollx', 02:08:50 INFO - 'cart']}, 02:08:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:08:50 INFO - 'tsvgr_opacity', 02:08:50 INFO - 'tart', 02:08:50 INFO - 'tscrollx', 02:08:50 INFO - 'cart']}, 02:08:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--disable-e10s'], 02:08:50 INFO - 'tests': ['tp5o']}, 02:08:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'tests': ['tp5o']}, 02:08:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--disable-e10s', 02:08:50 INFO - '--xperf_path', 02:08:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:50 INFO - 'tests': ['tp5n']}, 02:08:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:08:50 INFO - 'talos_options': ['--xperf_path', 02:08:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:50 INFO - 'tests': ['tp5n']}}, 02:08:50 INFO - 'talos.zip': {'path': '', 02:08:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:08:50 INFO - Running post-action listener: _resource_record_post_action 02:08:50 INFO - ##### 02:08:50 INFO - ##### Running create-virtualenv step. 02:08:50 INFO - ##### 02:08:50 INFO - Running pre-action listener: _resource_record_pre_action 02:08:50 INFO - Running main action method: create_virtualenv 02:08:50 INFO - Creating virtualenv /builds/slave/test/build/venv 02:08:50 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 02:08:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:50 INFO - Using real prefix '/usr' 02:08:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:51 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:53 INFO - Installing pip.................done. 02:08:53 INFO - Return code: 0 02:08:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:08:53 INFO - Using env: {'DISPLAY': ':0', 02:08:53 INFO - 'HOME': '/home/cltbld', 02:08:53 INFO - 'LANG': 'en_US.UTF-8', 02:08:53 INFO - 'LANGUAGE': 'en_US:en', 02:08:53 INFO - 'LOGNAME': 'cltbld', 02:08:53 INFO - 'MAIL': '/var/mail/cltbld', 02:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:53 INFO - 'MOZ_NO_REMOTE': '1', 02:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:53 INFO - 'NO_EM_RESTART': '1', 02:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:53 INFO - 'PWD': '/builds/slave/test', 02:08:53 INFO - 'SHELL': '/bin/bash', 02:08:53 INFO - 'SHLVL': '1', 02:08:53 INFO - 'TERM': 'linux', 02:08:53 INFO - 'TMOUT': '86400', 02:08:53 INFO - 'USER': 'cltbld', 02:08:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:53 INFO - '_': '/tools/buildbot/bin/python'} 02:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:53 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 02:08:53 INFO - Cleaning up... 02:08:53 INFO - Return code: 0 02:08:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:08:53 INFO - Using env: {'DISPLAY': ':0', 02:08:53 INFO - 'HOME': '/home/cltbld', 02:08:53 INFO - 'LANG': 'en_US.UTF-8', 02:08:53 INFO - 'LANGUAGE': 'en_US:en', 02:08:53 INFO - 'LOGNAME': 'cltbld', 02:08:53 INFO - 'MAIL': '/var/mail/cltbld', 02:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:53 INFO - 'MOZ_NO_REMOTE': '1', 02:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:53 INFO - 'NO_EM_RESTART': '1', 02:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:53 INFO - 'PWD': '/builds/slave/test', 02:08:53 INFO - 'SHELL': '/bin/bash', 02:08:53 INFO - 'SHLVL': '1', 02:08:53 INFO - 'TERM': 'linux', 02:08:53 INFO - 'TMOUT': '86400', 02:08:53 INFO - 'USER': 'cltbld', 02:08:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:53 INFO - '_': '/tools/buildbot/bin/python'} 02:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:53 INFO - Downloading/unpacking psutil>=0.7.1 02:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:55 INFO - Installing collected packages: psutil 02:08:55 INFO - Running setup.py install for psutil 02:08:55 INFO - building 'psutil._psutil_linux' extension 02:08:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:08:55 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 02:08:55 INFO - building 'psutil._psutil_posix' extension 02:08:55 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 02:08:55 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 02:08:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:55 INFO - Successfully installed psutil 02:08:55 INFO - Cleaning up... 02:08:56 INFO - Return code: 0 02:08:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:08:56 INFO - Using env: {'DISPLAY': ':0', 02:08:56 INFO - 'HOME': '/home/cltbld', 02:08:56 INFO - 'LANG': 'en_US.UTF-8', 02:08:56 INFO - 'LANGUAGE': 'en_US:en', 02:08:56 INFO - 'LOGNAME': 'cltbld', 02:08:56 INFO - 'MAIL': '/var/mail/cltbld', 02:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:56 INFO - 'MOZ_NO_REMOTE': '1', 02:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:56 INFO - 'NO_EM_RESTART': '1', 02:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:56 INFO - 'PWD': '/builds/slave/test', 02:08:56 INFO - 'SHELL': '/bin/bash', 02:08:56 INFO - 'SHLVL': '1', 02:08:56 INFO - 'TERM': 'linux', 02:08:56 INFO - 'TMOUT': '86400', 02:08:56 INFO - 'USER': 'cltbld', 02:08:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:56 INFO - '_': '/tools/buildbot/bin/python'} 02:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:08:58 INFO - Installing collected packages: mozsystemmonitor 02:08:58 INFO - Running setup.py install for mozsystemmonitor 02:08:58 INFO - Successfully installed mozsystemmonitor 02:08:58 INFO - Cleaning up... 02:08:58 INFO - Return code: 0 02:08:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:08:58 INFO - Using env: {'DISPLAY': ':0', 02:08:58 INFO - 'HOME': '/home/cltbld', 02:08:58 INFO - 'LANG': 'en_US.UTF-8', 02:08:58 INFO - 'LANGUAGE': 'en_US:en', 02:08:58 INFO - 'LOGNAME': 'cltbld', 02:08:58 INFO - 'MAIL': '/var/mail/cltbld', 02:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:58 INFO - 'MOZ_NO_REMOTE': '1', 02:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:58 INFO - 'NO_EM_RESTART': '1', 02:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:58 INFO - 'PWD': '/builds/slave/test', 02:08:58 INFO - 'SHELL': '/bin/bash', 02:08:58 INFO - 'SHLVL': '1', 02:08:58 INFO - 'TERM': 'linux', 02:08:58 INFO - 'TMOUT': '86400', 02:08:58 INFO - 'USER': 'cltbld', 02:08:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:58 INFO - '_': '/tools/buildbot/bin/python'} 02:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:58 INFO - Downloading/unpacking blobuploader==1.2.4 02:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:00 INFO - Downloading blobuploader-1.2.4.tar.gz 02:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:09:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:09:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:01 INFO - Downloading docopt-0.6.1.tar.gz 02:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:09:01 INFO - Installing collected packages: blobuploader, requests, docopt 02:09:01 INFO - Running setup.py install for blobuploader 02:09:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:09:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:09:01 INFO - Running setup.py install for requests 02:09:01 INFO - Running setup.py install for docopt 02:09:01 INFO - Successfully installed blobuploader requests docopt 02:09:01 INFO - Cleaning up... 02:09:01 INFO - Return code: 0 02:09:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:01 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')]} 02:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:01 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')]} 02:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:01 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 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:09:01 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 02:09:01 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 02:09:01 INFO - Using env: {'DISPLAY': ':0', 02:09:01 INFO - 'HOME': '/home/cltbld', 02:09:01 INFO - 'LANG': 'en_US.UTF-8', 02:09:01 INFO - 'LANGUAGE': 'en_US:en', 02:09:01 INFO - 'LOGNAME': 'cltbld', 02:09:01 INFO - 'MAIL': '/var/mail/cltbld', 02:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:01 INFO - 'MOZ_NO_REMOTE': '1', 02:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:01 INFO - 'NO_EM_RESTART': '1', 02:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:01 INFO - 'PWD': '/builds/slave/test', 02:09:01 INFO - 'SHELL': '/bin/bash', 02:09:01 INFO - 'SHLVL': '1', 02:09:01 INFO - 'TERM': 'linux', 02:09:01 INFO - 'TMOUT': '86400', 02:09:01 INFO - 'USER': 'cltbld', 02:09:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:01 INFO - '_': '/tools/buildbot/bin/python'} 02:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:01 INFO - Running setup.py (path:/tmp/pip-JLNzGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:02 INFO - Running setup.py (path:/tmp/pip-l_WSk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:02 INFO - Running setup.py (path:/tmp/pip-OoIr6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:02 INFO - Running setup.py (path:/tmp/pip-wExRpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:02 INFO - Running setup.py (path:/tmp/pip-jL5W_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:02 INFO - Running setup.py (path:/tmp/pip-kcUA6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:02 INFO - Running setup.py (path:/tmp/pip-TCGrbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:02 INFO - Running setup.py (path:/tmp/pip-rByokH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:02 INFO - Running setup.py (path:/tmp/pip-s8HWPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:02 INFO - Running setup.py (path:/tmp/pip-NqsabQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:02 INFO - Running setup.py (path:/tmp/pip-scGd1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:02 INFO - Running setup.py (path:/tmp/pip-3XO6lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:02 INFO - Running setup.py (path:/tmp/pip-suVBJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:02 INFO - Running setup.py (path:/tmp/pip-RW5rBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:02 INFO - Running setup.py (path:/tmp/pip-7fHxd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:03 INFO - Running setup.py (path:/tmp/pip-Jh4_L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:03 INFO - Running setup.py (path:/tmp/pip-VljbqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:09:03 INFO - Running setup.py install for manifestparser 02:09:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Running setup.py install for mozcrash 02:09:03 INFO - Running setup.py install for mozdebug 02:09:03 INFO - Running setup.py install for mozdevice 02:09:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Running setup.py install for mozfile 02:09:03 INFO - Running setup.py install for mozhttpd 02:09:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Running setup.py install for mozinfo 02:09:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Running setup.py install for mozInstall 02:09:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:09:03 INFO - Running setup.py install for mozleak 02:09:04 INFO - Running setup.py install for mozlog 02:09:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:09:04 INFO - Running setup.py install for moznetwork 02:09:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:09:04 INFO - Running setup.py install for mozprocess 02:09:04 INFO - Running setup.py install for mozprofile 02:09:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:09:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:09:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:09:04 INFO - Running setup.py install for mozrunner 02:09:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:09:04 INFO - Running setup.py install for mozscreenshot 02:09:04 INFO - Running setup.py install for moztest 02:09:04 INFO - Running setup.py install for mozversion 02:09:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:09:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:09:04 INFO - Cleaning up... 02:09:04 INFO - Return code: 0 02:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:04 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')]} 02:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:04 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')]} 02:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:04 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 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:09:04 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 02:09:04 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 02:09:04 INFO - Using env: {'DISPLAY': ':0', 02:09:04 INFO - 'HOME': '/home/cltbld', 02:09:04 INFO - 'LANG': 'en_US.UTF-8', 02:09:04 INFO - 'LANGUAGE': 'en_US:en', 02:09:04 INFO - 'LOGNAME': 'cltbld', 02:09:04 INFO - 'MAIL': '/var/mail/cltbld', 02:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:04 INFO - 'MOZ_NO_REMOTE': '1', 02:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:04 INFO - 'NO_EM_RESTART': '1', 02:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:04 INFO - 'PWD': '/builds/slave/test', 02:09:04 INFO - 'SHELL': '/bin/bash', 02:09:04 INFO - 'SHLVL': '1', 02:09:04 INFO - 'TERM': 'linux', 02:09:04 INFO - 'TMOUT': '86400', 02:09:04 INFO - 'USER': 'cltbld', 02:09:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:04 INFO - '_': '/tools/buildbot/bin/python'} 02:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:09:05 INFO - Running setup.py (path:/tmp/pip-eVOzBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:09:05 INFO - Running setup.py (path:/tmp/pip-ipRob3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:09:05 INFO - Running setup.py (path:/tmp/pip-WYMYao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:09:05 INFO - Running setup.py (path:/tmp/pip-XPvkKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:09:05 INFO - Running setup.py (path:/tmp/pip-5lnWEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:09:05 INFO - Running setup.py (path:/tmp/pip-lqSRxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:09:05 INFO - Running setup.py (path:/tmp/pip-x85sPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:09:05 INFO - Running setup.py (path:/tmp/pip-eBobtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:09:05 INFO - Running setup.py (path:/tmp/pip-6V9KF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:09:05 INFO - Running setup.py (path:/tmp/pip-OyrURC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:09:05 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)) 02:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:09:05 INFO - Running setup.py (path:/tmp/pip-zTBt6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:09:06 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)) 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:09:06 INFO - Running setup.py (path:/tmp/pip-CVsc1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:09:06 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)) 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:09:06 INFO - Running setup.py (path:/tmp/pip-y9imst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:09:06 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)) 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:09:06 INFO - Running setup.py (path:/tmp/pip-XAWuh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:09:06 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)) 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:06 INFO - Running setup.py (path:/tmp/pip-KrOAYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:09:06 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)) 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:09:06 INFO - Running setup.py (path:/tmp/pip-MbcR4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:09:06 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)) 02:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:09:06 INFO - Running setup.py (path:/tmp/pip-QF0EH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 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)) 02:09:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:09:06 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 02:09:06 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 02:09:06 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 02:09:06 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 02:09:06 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 02:09:06 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 02:09:08 INFO - Downloading blessings-1.6.tar.gz 02:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:09:08 INFO - Installing collected packages: blessings 02:09:08 INFO - Running setup.py install for blessings 02:09:08 INFO - Successfully installed blessings 02:09:08 INFO - Cleaning up... 02:09:08 INFO - Return code: 0 02:09:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:08 INFO - Reading from file tmpfile_stdout 02:09:08 INFO - Current package versions: 02:09:08 INFO - argparse == 1.2.1 02:09:08 INFO - blessings == 1.6 02:09:08 INFO - blobuploader == 1.2.4 02:09:08 INFO - docopt == 0.6.1 02:09:08 INFO - manifestparser == 1.1 02:09:08 INFO - mozInstall == 1.12 02:09:08 INFO - mozcrash == 0.17 02:09:08 INFO - mozdebug == 0.1 02:09:08 INFO - mozdevice == 0.48 02:09:08 INFO - mozfile == 1.2 02:09:08 INFO - mozhttpd == 0.7 02:09:08 INFO - mozinfo == 0.9 02:09:08 INFO - mozleak == 0.1 02:09:08 INFO - mozlog == 3.1 02:09:08 INFO - moznetwork == 0.27 02:09:08 INFO - mozprocess == 0.22 02:09:08 INFO - mozprofile == 0.28 02:09:08 INFO - mozrunner == 6.11 02:09:08 INFO - mozscreenshot == 0.1 02:09:08 INFO - mozsystemmonitor == 0.0 02:09:08 INFO - moztest == 0.7 02:09:08 INFO - mozversion == 1.4 02:09:08 INFO - psutil == 3.1.1 02:09:08 INFO - requests == 1.2.3 02:09:08 INFO - wsgiref == 0.1.2 02:09:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:08 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 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:09:08 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 02:09:08 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 02:09:08 INFO - Using env: {'DISPLAY': ':0', 02:09:08 INFO - 'HOME': '/home/cltbld', 02:09:08 INFO - 'LANG': 'en_US.UTF-8', 02:09:08 INFO - 'LANGUAGE': 'en_US:en', 02:09:08 INFO - 'LOGNAME': 'cltbld', 02:09:08 INFO - 'MAIL': '/var/mail/cltbld', 02:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:08 INFO - 'MOZ_NO_REMOTE': '1', 02:09:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:08 INFO - 'NO_EM_RESTART': '1', 02:09:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:08 INFO - 'PWD': '/builds/slave/test', 02:09:08 INFO - 'SHELL': '/bin/bash', 02:09:08 INFO - 'SHLVL': '1', 02:09:08 INFO - 'TERM': 'linux', 02:09:08 INFO - 'TMOUT': '86400', 02:09:08 INFO - 'USER': 'cltbld', 02:09:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:08 INFO - '_': '/tools/buildbot/bin/python'} 02:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 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)) 02:09:09 INFO - Cleaning up... 02:09:09 INFO - Return code: 0 02:09:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:09 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 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:09:09 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 02:09:09 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 02:09:09 INFO - Using env: {'DISPLAY': ':0', 02:09:09 INFO - 'HOME': '/home/cltbld', 02:09:09 INFO - 'LANG': 'en_US.UTF-8', 02:09:09 INFO - 'LANGUAGE': 'en_US:en', 02:09:09 INFO - 'LOGNAME': 'cltbld', 02:09:09 INFO - 'MAIL': '/var/mail/cltbld', 02:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:09 INFO - 'MOZ_NO_REMOTE': '1', 02:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:09 INFO - 'NO_EM_RESTART': '1', 02:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:09 INFO - 'PWD': '/builds/slave/test', 02:09:09 INFO - 'SHELL': '/bin/bash', 02:09:09 INFO - 'SHLVL': '1', 02:09:09 INFO - 'TERM': 'linux', 02:09:09 INFO - 'TMOUT': '86400', 02:09:09 INFO - 'USER': 'cltbld', 02:09:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:09 INFO - '_': '/tools/buildbot/bin/python'} 02:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:09 INFO - Downloading/unpacking jsonschema 02:09:09 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 02:09:09 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 02:09:09 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 02:09:09 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 02:09:09 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 02:09:09 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 02:09:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:09:11 INFO - Downloading/unpacking functools32 (from jsonschema) 02:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:11 INFO - Downloading functools32-3.2.3-2.tar.gz 02:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:09:11 INFO - warning: no files found matching '*.txt' 02:09:11 INFO - no previously-included directories found matching 'build' 02:09:11 INFO - no previously-included directories found matching 'dist' 02:09:11 INFO - no previously-included directories found matching '.git*' 02:09:11 INFO - Installing collected packages: jsonschema, functools32 02:09:11 INFO - Running setup.py install for functools32 02:09:11 INFO - warning: no files found matching '*.txt' 02:09:11 INFO - no previously-included directories found matching 'build' 02:09:11 INFO - no previously-included directories found matching 'dist' 02:09:11 INFO - no previously-included directories found matching '.git*' 02:09:11 INFO - Successfully installed jsonschema functools32 02:09:11 INFO - Cleaning up... 02:09:11 INFO - Return code: 0 02:09:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd18a688f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15405a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', '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 02:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:09:11 INFO - Using env: {'DISPLAY': ':0', 02:09:11 INFO - 'HOME': '/home/cltbld', 02:09:11 INFO - 'LANG': 'en_US.UTF-8', 02:09:11 INFO - 'LANGUAGE': 'en_US:en', 02:09:11 INFO - 'LOGNAME': 'cltbld', 02:09:11 INFO - 'MAIL': '/var/mail/cltbld', 02:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:11 INFO - 'MOZ_NO_REMOTE': '1', 02:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:11 INFO - 'NO_EM_RESTART': '1', 02:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:11 INFO - 'PWD': '/builds/slave/test', 02:09:11 INFO - 'SHELL': '/bin/bash', 02:09:11 INFO - 'SHLVL': '1', 02:09:11 INFO - 'TERM': 'linux', 02:09:11 INFO - 'TMOUT': '86400', 02:09:11 INFO - 'USER': 'cltbld', 02:09:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:11 INFO - '_': '/tools/buildbot/bin/python'} 02:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:09:11 INFO - Downloading/unpacking flake8 02:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:09:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02: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 02: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 02: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 02: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 02: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 02: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 02:09:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:09:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02: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 02: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 02: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 02: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 02: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 02: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 02:09:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:09:14 INFO - no previously-included directories found matching 'docs/_build' 02:09:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:09:14 INFO - Running setup.py install for pep8 02:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:09:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:09:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:09:14 INFO - no previously-included directories found matching 'docs/_build' 02:09:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:09:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:09:14 INFO - Cleaning up... 02:09:14 INFO - Return code: 0 02:09:14 INFO - Running post-action listener: _resource_record_post_action 02:09:14 INFO - Running post-action listener: _start_resource_monitoring 02:09:14 INFO - Starting resource monitoring. 02:09:14 INFO - ##### 02:09:14 INFO - ##### Running install step. 02:09:14 INFO - ##### 02:09:14 INFO - Running pre-action listener: _resource_record_pre_action 02:09:14 INFO - Running main action method: install 02:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:09:14 INFO - Reading from file tmpfile_stdout 02:09:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:09:15 INFO - Reading from file tmpfile_stdout 02:09:15 INFO - Output received: 02:09:15 INFO - Usage: mozinstall [options] installer 02:09:15 INFO - Options: 02:09:15 INFO - -h, --help show this help message and exit 02:09:15 INFO - -d DEST, --destination=DEST 02:09:15 INFO - Directory to install application into. [default: 02:09:15 INFO - "/builds/slave/test"] 02:09:15 INFO - --app=APP Application being installed. [default: firefox] 02:09:15 INFO - mkdir: /builds/slave/test/build/application 02:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:09:31 INFO - Reading from file tmpfile_stdout 02:09:31 INFO - Output received: 02:09:31 INFO - /builds/slave/test/build/application/firefox/firefox 02:09:31 INFO - Running post-action listener: _resource_record_post_action 02:09:31 INFO - ##### 02:09:31 INFO - ##### Running run-tests step. 02:09:31 INFO - ##### 02:09:31 INFO - Running pre-action listener: _resource_record_pre_action 02:09:31 INFO - Running main action method: run_tests 02:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:09:31 INFO - Python 2.7.3 02:09:31 INFO - Return code: 0 02:09:31 INFO - grabbing minidump binary from tooltool 02:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:09:31 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 0x15cf410>, '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 0x15d0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15d07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:09:31 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 02:09:31 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 02:09:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:09:31 INFO - Return code: 0 02:09:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:09:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:09:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:09:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:09:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:09:32 INFO - Return code: 0 02:09:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 02:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 02:09:32 INFO - Using env: {'DISPLAY': ':0', 02:09:32 INFO - 'HOME': '/home/cltbld', 02:09:32 INFO - 'LANG': 'en_US.UTF-8', 02:09:32 INFO - 'LANGUAGE': 'en_US:en', 02:09:32 INFO - 'LOGNAME': 'cltbld', 02:09:32 INFO - 'MAIL': '/var/mail/cltbld', 02:09:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:09:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:32 INFO - 'MOZ_NO_REMOTE': '1', 02:09:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:09:32 INFO - 'NO_EM_RESTART': '1', 02:09:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:32 INFO - 'PWD': '/builds/slave/test', 02:09:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:09:32 INFO - 'SHELL': '/bin/bash', 02:09:32 INFO - 'SHLVL': '1', 02:09:32 INFO - 'TERM': 'linux', 02:09:32 INFO - 'TMOUT': '86400', 02:09:32 INFO - 'USER': 'cltbld', 02:09:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886', 02:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:32 INFO - '_': '/tools/buildbot/bin/python'} 02:09:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 02:09:32 INFO - mozversion application_buildid: 20160417233026 02:09:32 INFO - mozversion application_changeset: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 02:09:32 INFO - mozversion application_display_name: Nightly 02:09:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:09:32 INFO - mozversion application_name: Firefox 02:09:32 INFO - mozversion application_remotingname: firefox 02:09:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:09:32 INFO - mozversion application_vendor: Mozilla 02:09:32 INFO - mozversion application_version: 48.0a1 02:09:32 INFO - mozversion platform_buildid: 20160417233026 02:09:32 INFO - mozversion platform_changeset: 4d5b0cdb72fe52f843c61a5df8f6b8ed35758be8 02:09:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:09:32 INFO - mozversion platform_version: 48.0a1 02:09:32 INFO - using testdate: 1460970572 02:09:32 INFO - actual date: 1460970572 02:09:32 INFO - starting webserver on 'localhost:54268' 02:09:32 INFO - SUITE-START | Running 2 tests 02:09:32 INFO - TEST-START | dromaeo_css 02:09:32 INFO - operating with platform_type : linux_ 02:09:32 INFO - Initialising browser for dromaeo_css test... 02:09:32 INFO - TEST-INFO | started process 10506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41BRM_/profile http://localhost:54268/getInfo.html) 02:09:36 INFO - PROCESS | 10506 | 02:09:36 INFO - PROCESS | 10506 | (process:10575): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:09:36 INFO - PROCESS | 10506 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 02:09:37 INFO - PROCESS | 10506 | __metrics Screen width/height:1600/1200 02:09:37 INFO - PROCESS | 10506 | colorDepth:24 02:09:37 INFO - PROCESS | 10506 | Browser inner width/height: 1024/697 02:09:37 INFO - PROCESS | 10506 | __metrics 02:09:37 ERROR - PROCESS | 10506 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:09:38 INFO - TEST-INFO | 10506: exit 0 02:09:38 INFO - Browser initialized. 02:09:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:09:38 INFO - TEST-INFO | started process 10626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41BRM_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:40 INFO - PROCESS | 10626 | 02:09:40 INFO - PROCESS | 10626 | (process:10686): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:09:50 INFO - PROCESS | 10626 | RSS: Main: 163446784 02:09:50 INFO - PROCESS | 10626 | 02:10:40 INFO - PROCESS | 10626 | 1460970640177 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] 02:12:47 INFO - PROCESS | 10626 | Cycle 1(1): loaded http://localhost:54268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54268/tests/dromaeo/cssquery-ext.html) 02:12:48 INFO - PROCESS | 10626 | RSS: Main: 168730624 02:12:48 INFO - PROCESS | 10626 | 02:15:50 INFO - PROCESS | 10626 | Cycle 1(1): loaded http://localhost:54268/tests/dromaeo/cssquery-ext.html (next: http://localhost:54268/tests/dromaeo/cssquery-jquery.html) 02:15:51 INFO - PROCESS | 10626 | RSS: Main: 166920192 02:15:51 INFO - PROCESS | 10626 | 02:18:53 INFO - PROCESS | 10626 | Cycle 1(1): loaded http://localhost:54268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54268/tests/dromaeo/cssquery-mootools.html) 02:18:53 INFO - PROCESS | 10626 | RSS: Main: 166338560 02:18:53 INFO - PROCESS | 10626 | 02:21:55 INFO - PROCESS | 10626 | Cycle 1(1): loaded http://localhost:54268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54268/tests/dromaeo/cssquery-prototype.html) 02:21:56 INFO - PROCESS | 10626 | RSS: Main: 163532800 02:21:56 INFO - PROCESS | 10626 | 02:24:58 INFO - PROCESS | 10626 | Cycle 1(1): loaded http://localhost:54268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54268/tests/dromaeo/cssquery-yui.html) 02:24:59 INFO - PROCESS | 10626 | RSS: Main: 165416960 02:24:59 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | Cycle 1(1): loaded http://localhost:54268/tests/dromaeo/cssquery-yui.html (next: http://localhost:54268/tests/dromaeo/cssquery-dojo.html) 02:28:01 INFO - PROCESS | 10626 | RSS: Main: 167186432 02:28:01 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | __start_tp_report 02:28:01 INFO - PROCESS | 10626 | _x_x_mozilla_page_load 02:28:01 INFO - PROCESS | 10626 | _x_x_mozilla_page_load_details 02:28:01 INFO - PROCESS | 10626 | |i|pagename|runs| 02:28:01 INFO - PROCESS | 10626 | |0;dojo.html;3149.8897538586148;3173.2542852429688;3175.1268401189677;3217.9517307240394;3222.452183128868;5420.241166236725;5449.318835145602;5479.342478902532;5485.204645326436;5502.0921547944645;5416.322959630046;5442.455754424565;5454.127339625661;5459.099248623972;5557.916631250535;4923.753812309379;4974.403071631409;4978;5043.470435604264;5094.490550944913;5032.874178145557;5039.44566097729;5081.314022606938;5096.159133742928;5119.641625086246;4875.951240487603;4945.208766597345;4977.477364876672;5012.273220383042;5022.347094877642;4957.256411538262;4986.4265609455015;4986.526280003394;4989.301497790312;5023.422306434733;4931.580815630676;4953.900921981576;4966.826161084381;4979.029089327582;5013.222950442687;5272.209168624699;5313.920291195635;5360.437154098802;5394.514493695547;5413.106837371868;5730.598858079936;5737.168110623978;5738.167965645;5741.712914354265;5747.1666608341975;5786.68173250471;5787.276590426197;5787.276590426197;5787.623804452697;5796.681182534959;5459.781608735646;5496.148097044925;5503.3395992481155;5514.228008078872;5541.362743284533;5806.82579522615;5849.707514624251;5855.151003104526;5863.442972917651;5866.472017518444;5585.301837270341;5622.269105016404;5628.85927851807;5629.043062679354;5632.127020311858;5801.477866991991;5831.854203644943;5836.212111364996;5839.9124013139835;5890.823275301748;5756.856078597984;5757.193992841006;5784.82645520635;5791.0734282514595;5844.26946631671;5706.828795136153;5720;5740.56945729072;5756.884862302814;5769.826905192851;4387.232234359039;4392.450943632046;4394.187075390999;4423.778811059434;4428.247197976351;3902.317094508506;3909.3745000799736;3916.060145565101;3935.685145188378;3938.6849052076336;5398.73006349681;5432.239486471897;5534.418886016991;5553.08374118266;5554.750036248379;5734.5125664319;5769.423057694281;5776;5783.739731712083;5829.183914252008;5509.311336082989;5519.420460851633;5525.392206857243;5528.889422211533;5531.253280807039;4861.29511220871;4941.234108713155;4957.851264462072;4970.552650261494;5002.474740152232;6050.6974651267265;6051.576389652682;6068.605540639845;6071.908921366183;6075.908861367083;5798.710064496674;5803.448672376117;5859.648421094748;5863.677497737665;5872.0898260769645;5919.230500034968;5922.466977972003;5973.522118230618;6002.789902353396;6016.639001659914;5686.545076393796;5703.543716502587;5705.885882282248;5719.084946408555;5728.513076388554;5757.0788673811985;5773.076307790733;5776.797812076557;5810.593258471867;5821.534277257894;5585.804496842591;5644.435556444323;5685.800996965252;5690.459406356389;5698.886022279614;5625.409332020079;5718.370979192368;5721.141828725725;5725.16985037159;5786.797462088806;5554.888902221852;5558.805441809517;5582.804601838916;5595.244641973281;5609.21470994053;5585.944140558705;5728.054870946247;5728.255326807488;5755.65466072037;5801.36185019639;5580.609357344947;5606.607537472338;5613.410591887956;5621.156826476062;5630.380658127685 02:28:01 INFO - PROCESS | 10626 | |1;ext.html;582.9708514574273;632.4908448698801;661.9304972977837;665.5707068940534;688.284184448174;34691.65308346916;35948.10129746755;35988.82005589972;36109.097272568135;36183.276334473296;35981.1004724882;36365;36428;36582.26835463289;36586.268274634494;8299.502029878211;8384.245417912387;8430.452020618672;8466.153384661515;8498.107698691641;8354.540500272513;8622.482651040958;8656.740297791077;8676.739697809044;8698.956505217466;8674.609642566069;8700;8721.694740684077;8722.956385218065;8743.12568743127;8452.535110568917;8630;8637.611307491177;8639.43843650167;8665.176808203274;8613.913860861374;8742.256908162813;8749.693760718408;8781.121887811232;8802.779930501725;31519.36961260785;36824.63175368239;37360.25279494422;37394.813025934694;37435.812820935724;3199.84159200041;3318.1206980150278;3433.2446861690387;3742.4760533525327;4023.0746928206677;26126;26936.461270774475;26956.86521567399;27016.59475107875;31065.378692426024;4006.258842114218;4060.4315395844606;4108.650764685005;4128;4212.936805947913;205485;207780;208738;208788;208944;52500.73749631227;52717.73641131847;52842;52846.735766320926;52853;62457.375426246064;63598.36401636017;63681.68159159175;64465.67767161134;64607.35392646107;15242.085474871543;15304.464343747915;15317;15325.386984520494;15473.767893481607;12908.35458227085;13079.738405231841;13089.149205301625;13103.27931963732;13179.406926688322;18439.72340414895;18568.350107746162;18746.718799218022;19487.512812179808;19553.0223488825;6970.860582788316;7270.927290727131;7330.010448589373;7422.517536360119;7431.665575049135;1009.2733232072895;1067.8611780468489;1144.3837473583603;1152.2798251093068;1173.1494666366987;30133.397332053235;30622.846885765874;31258;31381.843090784856;31749.523757143663;1173.8297946797666;1213.990845151276;1217.9025677945742;1246.6010876519426;1278.7442511497738;16210.027398356136;16220.51338459848;16300.184990750415;16559.337626495046;16831.410900618663;453195;458267;459894;460524;461788;54925;55694;55723;56018.719906400205;56043.71978140083;1369.1442848219863;1399.3353157250224;1412.039812927199;1418.6240646228757;1514.8409417011276;30370.696293036788;30647.693523065376;30699.693003069682;31045.534316985715;31200.531992019685;48396.5160348392;48921.2661810066;48931.75534122306;49134.75432622814;49380;303437;304876;306211;306611;306811;27258.591121132802;27297.86351068232;27822.721772782013;27844.721552785024;27865.58201627018;46477.53522464732;46619.30071048869;46977;47239.29141062818;47337.7633111846;38416.42375364316;39744.602553975245;39980.400293996194;40224.798876005436;40250.59749402585;38042.61957380391;38558.80720596491;39481.2103757929;40072.59927400688;40369.59630403658;39885.60114398819;39915;40283.3957490632;41476.58523414848;41668.791656041525;31079.378412432077;31271.218219544695;31753;32191.839040804647;32210.35579288448;25414;25735.871320643277;26109.869450652626;26254.606180907685;26297.079602214595 02:28:01 INFO - PROCESS | 10626 | |2;jquery.html;392.51524367406256;394.8203567376844;400.76755481820544;406.94913135858036;412.36084069691987;13586.535433464478;17424.215910284034;18091.366802161927;18134.727979080326;18197.72703409448;14664.340104695288;16970.575735606584;17389.39137130201;17723.82276177241;17787.64424711505;4982.651214414992;5493.945060549383;5556.194351818984;5560;5560.2493663355535;5475.4524547545125;5653.208550802891;5667.263255776743;5731.111677689964;5745.942540574582;5634.295713035871;5650.773969041254;5659.943400565983;5740.913886291709;5750.33871104822;5481.342238931354;5661;5662.094064949609;5697.003024470721;5713.74288157034;5005.874853128665;5019.42276638184;5037.29477873098;5053.519915608012;5063.1898896176435;20708.378748637566;21010.894945525175;21034.684479732816;21601.891990540105;21678;2235.944101397462;2408.446057406789;2488.32815139913;2702.702702702701;2707.241972247774;13288.468461261538;13680.52118175869;13788.724225515534;13945.721085578332;14013.789793153112;1948.5713143108494;1995.1919472613615;2002.9899850500653;2006.518435575466;2015.133492598182;70713.64643176802;71104.2889571108;71253.64373178153;71742.28257717408;76808.61595691986;10305.433201173857;10403;10548.947255263674;10598.417087060132;10731.463426828628;14629;14844.851551484348;14850.628734281514;14945.252737363306;14958.177300248373;7252.927470725225;7530.6611202496015;7770.106437759617;8001.399895007898;8118.75643730689;7667.808304792425;7677.731279405194;7739.264769846855;7773.961130194426;7877.172896845863;4494.820207191676;4517.435320584927;4568.81724731007;4570.771461426915;4660.370849935283;1882.2941396976134;1910.169076451748;1971.5804620673093;1985.0471773548777;1996.7204591357222;968.3850754770772;996.0985308296003;1008.7487464740683;1103.812351900179;1120.2494328799723;17637.559061023578;17794.91545558926;17949.871079930264;18407.815921840876;18614.34849780251;1018.8013337399284;1026.1585499890018;1045.592219034577;1074.6507385099874;1086.473060565625;9907.851382229272;10066.748331291776;10147.660381123387;10269.794604108025;10333.74165645865;444406;468409;469751;470831;471361;88188;88226;88683.11316886877;88690.55654721815;89135;1052.7736536644659;1053.8050460664801;1056.4242487844144;1058.4760543531002;1073.2272763610188;15772.68454630924;15774.447894323643;15802.60493487672;15897.364105435652;15975.520734377988;35300.646993529735;35627.28745425129;35994.4600830993;36471.27057458889;36836.44745328876;47864.7606761964;49717.254241185685;49954.500454996436;50774;50821.49178508168;7239.239879812544;7423.962880185781;7781.182975787688;7868.8819667706175;8008.239217274349;7291.8541629168185;9672.516374181121;11973.341466219441;12328.81506777381;12571.308578028296;11136.276142050741;11205.719857003314;11395.772084558428;11426.657200284004;11477.253978491372;10939.56241750321;11143.72140696489;11229.71925701864;11254.21220514556;11281;5729.083346664514;6884;11286.887131128584;11476.270212181242;11587.768244635228;7274.16347120088;7388.889166662612;7415.5179913305465;7491.250874912465;7664.616769161631;9934.552945117342;11052.336859788438;11201.383923884265;11281.379524126252;11376.203665743318 02:28:01 INFO - PROCESS | 10626 | |3;mootools.html;1468.7429699802533;1497.0867770659895;1601.6876709041735;1686.1316422042657;1729.6108375615481;7632.656530456129;8351.248387645112;8375.832483350345;8634.309255259579;8665.956670216656;8463.153684631534;8480.95759521203;8515.78710532237;8532.23209911108;8547.230749232567;2242.0471299697606;2248.5952528544935;2263.879379707039;2264.852784568998;2279.7150356205475;2251.8536295140843;2256.571251462225;2282.486440550871;2296.127471560813;2296.678465014891;2194.7585765565773;2207.6909232707435;2208;2216.2243214874748;2247.4269061389405;2241.663750437431;2256.7743225677464;2257.571061498318;2260.08466571039;2263.5586060718165;2191.638379667353;2193.6599827026835;2194.8353873459555;2202.4714068623575;2204.4599073227164;8512.1487851215;8676.479411235347;8728.650853965833;8738.912610873873;8750.606222719993;4918.409790825124;5027.170516864713;5056.165732654108;5065.569426598743;5077.517635824628;3076.615423072116;3137.4823154179535;3137.5607414961923;3181.6341120771176;3190.1067701043744;980.6616717232544;1005.7636455432968;1007.1590222164501;1007.8437842134481;1016.8881423043459;11474.942625286903;11514.769704605944;11535.307881527135;11541.480633371519;11618.07055435563;4106.609872062149;4124.546299907008;4292.806823692878;4322.697411181187;4387.561243875651;9206.76983075415;9211;9212.216961558343;9239.445633262027;9265.212456941235;5021.121303771825;5037.823676171316;5040.042391945519;5057.519535644108;5069.1635880079375;4218.303979843353;4575.3365761965;4666.4633567139535;4679.766011699401;4714.834980775657;3857.7492462989817;3879.3792993120965;3953.0512676957323;3979.801009949491;4002.15954649521;1266.0441366768032;1266.0757646917803;1289.4390939941156;1294.8834604885606;1302.3813688497887;695.1484431571284;768.4889548450218;790.1593770395419;860.3418384935529;906.6146887572887;5827.096799996008;6098;6141.6007959482495;6219.378062193744;6273.309935907047;950.7290422229631;981.3572110267786;1006.5319626373625;1015.8476228565627;1018.2108865629197;4014.3577027675433;4106.281400754856;4108.096218831853;4148.896277593084;4161.583841615814;10465.9476702616;10949.4525273736;10979.121670266359;11069.05912997388;11091.889081109086;10844.024037836632;10882.238243322892;10901.400422976812;10958.28771129874;10966.890331096587;8069.838603227902;8179.059408168017;8206.138355472709;8227.300679442194;8234.464759790595;5824.767009319749;5840.970795145997;5960.195373624679;6062.605930614496;6080.179175811209;9726.562304696447;9857.901420985985;10087;10114.342567733074;10178.389296642225;10059.245556583139;10122.949385253027;10189.43958082283;10191.286609937233;10464.215183861088;6831.863362732817;7461.253874612496;7472.327490525879;7536.886946695914;7671.156172821097;7895.64469598858;7900.4074694397;7964.721234756756;7979.9601001994615;8030.156833532628;7287.8542429152185;7395.593242371721;7649.808754781175;7713.2286771322415;7720.53676779395;7249.528780629243;7413.481056326005;7422.628868556442;7475;7488.475806693479;6817.897731533932;6873.759418420332;6898;6905.827354316182;6924.58452492852;4926.433460151985;4950.8267210647455;4971.676841005467;5051.217061355495;5162.561182299396;4941.209406494943;4942.678725882806;4997;5026.3214466048075;5145.948540514547 02:28:01 INFO - PROCESS | 10626 | |4;prototype.html;322.46792791893387;332.65736291619635;339.7638641144404;341.08248810699234;343.7915726222329;5837.182794408786;5943.910841337383;5985.25184351956;6109.725062372193;6172.228471441075;6007.789727359544;6008.218931538905;6016.87966240676;6024.9698751506185;6049.485793707529;4608.5621865922685;4613.630909527246;4616.930746038812;4620.768961551926;4625.537446255373;4481.977590112045;4600.217962946307;4609.539046095397;4611.262198048313;4615.976920115411;4510.345999830039;4526.954730452702;4541.409616749818;4550.38569793077;4561.840335588255;4535.319702044687;4535.909281814362;4550.180967425862;4556.794944227501;4562.087582483517;3735.4396840474146;3943.645071943539;3945.7237993340477;4014.574825936809;4018.1361007383553;5719.485246327808;5726.742296596663;5743.310802703661;5763.337216220147;5812.157237200582;5136.306598609177;5183.326167598226;5213.218017297398;5221.843344699665;5234.42421333653;5991.970040149815;6190.102435146879;6255.906161407583;6335.465813674521;6354.523410744213;4310.590493903074;4314.094040251551;4316.287812510964;4320.200762858881;4320.870373888788;6288.496920246415;6489.67551622417;6537.771178008795;6561.901571476432;6591.143151390336;4412.294032954712;4436.157130145262;4446.933296000562;4459.55064604005;4461.286194208911;4509.255972764523;4509.661775366861;4511.300748384006;4514.255147900625;4517.073999830092;4980.103581355391;5171.922421163686;5186.870328241824;5227.817026404057;5231.895362092737;6137.877242455215;6319.178506794087;6320.178376811077;6424.871502569922;6427.485801135898;1549.636320038359;1566.4204244429634;1570.4110958390604;1572.4732214708201;1574.559123445437;972.4943029624555;1001.5142655811925;1005.5877090392904;1023.0638965346625;1031.3657100882904;6114.908276375858;6121;6121.602095863755;6161.938380616137;6163.907541386883;6483.546151769331;6528.836779080561;6540;6560.179977502812;6586.538942274091;6022.096685497123;6084.939150608438;6094.908576371358;6101.908471372933;6137.263528376623;3496.615372309044;3512.4028915084496;3518.9824050879583;3543.6456354364873;3545.1137215696076;6665.933340666628;6740.730370785212;6764.188297404343;6775.72897084121;6790.932090679129;6681.231658359254;6693.397594216543;6706.094677218611;6710.16122984627;6723.462123030145;6555.704993275314;6750.459963202932;6800.353966373186;6808.387245147861;6809.421199198025;6489.837754056186;6500.349965003462;6528.2492513359675;6528.836779080561;6532.575382600306;6243.62742157977;6416.197975253093;6425.228972523327;6448.774292899726;6456.418922297016;6731.038343129007;6756.290589488033;6756.560823546453;6774.525783195129;6781.3896749290825;4371.409859668904;4393.637972228619;4425.579569940851;4448.977755111204;4460.107978404268;6331.873362532816;6408;6502.512311576746;6524.380183882524;6595.406413422815;6399.93600064012;6408.839779005562;6426.389492998158;6432.163818703539;6436.292007879036;6217.782377616762;6406.007068904327;6418.133551970424;6424.132742079946;6424.710888009958;6291.748330066746;6301.117843502005;6305.4009869062365;6308.684565771785;6341;6450.838729031811;6455.838604034937;6457;6487.545871789118;6502.512311576746;6104.359042300494;6240.375962403723;6253.124562561154;6258.155149055002;6266.496040950048 02:28:01 INFO - PROCESS | 10626 | |5;yui.html;728.9416846652267;736.9042024536809;749.2544917806783;753.2016062973249;867.31482129118;14011.789823152661;14555.199464029474;14658.193799341032;14668.559943201708;14697.92651036746;13454.125481843674;13513.662158446044;13567.728645427085;13671.658208544792;13687.3156342183;801.1187693537121;819.2831272636458;826.5330088499978;832.0805509911521;835.3150416658343;830.2486249943811;830.5805568188057;831.7795784117213;832.9875051874196;835.8202986357932;853.3940901959617;853.4580541356221;858.3390789092396;859.3855393393723;865.8701194820765;849.142366210126;852.4842470305468;853.9701110461104;858.9398742088056;862.1163307609719;614.8985417406167;614.9938500614982;624.5128799536369;626.3266987987931;628.9905651415187;13123.540676076387;13174.27541485218;13202.735945281136;13217.140885842486;13229.536966206233;13519.121257118355;13611;13643.38604762788;13712.725745485035;13742.381592828347;10928.890711092947;10931.620282573886;10974.835377469344;11114.277571957797;11227.382493962828;3656.1773600939578;3677.5586929568353;3704.111013356802;3828.5022947016987;3865.4201869719486;53135.734321328535;53324.46675533272;53761;53792.731036344565;54289.72855135739;10393.58425662965;10510.684679459628;10528.420936848393;10625.149988000941;10742.892571074346;19134.234630614897;19290.22839086449;19322.32371866978;19332.613347732968;19333.226670933003;7840.215978402114;7920.485168464032;7922.524648521107;7998.402914680731;8043.919560804317;4506.098780243964;4705.717656940595;4740.620750339965;4756.6670333077045;4784.617230621611;3134.9686503134676;3205.759568032407;3232.8060316381093;3237.8866739664;3245.432049391347;528.6141116984622;545.5390195285057;551.6827824001135;568.687222027883;572.9713514324267;632.6046221111806;753.8831481120435;754.2608243920988;756.9507981981153;775.7478819383723;7715.498492597963;8259.091499935003;8615.310775137974;8735.737927862174;9034.412763170372;715.9749408770668;724.1129616220088;734.5959722152794;743.5687301365303;745.4744405194325;4187.20443115807;4348.5216626171095;4361.5856493633055;4389.217057233995;4475.7985890635;55706;55721;56706.71646641823;57222.7138864303;57356.139657905165;50796;50950.23574646383;51182.23226651529;51424.48575514197;51460;46200.537994620296;46420.535794642296;46574.76712616415;46685.533144668116;46999.765001174776;8215.260626543639;8569.700060497853;8570.871436928575;8579.914200857911;8731.607077681392;29831.254218644706;30172.849135754182;30543.54184687187;30651.54022689617;31173;38773.61226387813;39205.803970981106;39373.60626393699;39760;41106.79446602748;12103.757924841279;12329.705003919418;12415.503379864704;12446.564370246997;12472.5010999559;12576.937115314366;12689.682757931125;13149.868501315246;13196.934015329862;13220.933895330847;12047.867824071804;12253.632391028283;12507.187032842836;12671.049671274875;12861.421236044587;11974;12260.816087758869;12275.2021118627;12279.2018518796;12484.375781211085;10377.636782712569;11159.27464714791;11278.605248816251;11323.830142547704;11834.230774999598;9973.501324933579;10006.799864002825;10154.746131346776;10472.424016679155;10561.366318020637;9896.356736812084;10065.899341006496;10081.243906707174;10262.538185781508;10309.07218350352 02:28:01 INFO - PROCESS | 10626 | __end_tp_report 02:28:01 INFO - PROCESS | 10626 | __start_cc_report 02:28:01 INFO - PROCESS | 10626 | _x_x_mozilla_cycle_collect,321 02:28:01 INFO - PROCESS | 10626 | __end_cc_report 02:28:01 INFO - PROCESS | 10626 | __startTimestamp1460971681712__endTimestamp 02:28:01 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | ------- Summary: start ------- 02:28:01 INFO - PROCESS | 10626 | Number of tests: 6 02:28:01 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | [#0] dojo.html Cycles:165 Average:5395.74 Median:5595.24 stddev:600.72 (10.7%) stddev-sans-first:576.15 02:28:01 INFO - PROCESS | 10626 | Values: 3149.9 3173.3 3175.1 3218.0 3222.5 5420.2 5449.3 5479.3 5485.2 5502.1 5416.3 5442.5 5454.1 5459.1 5557.9 4923.8 4974.4 4978.0 5043.5 5094.5 5032.9 5039.4 5081.3 5096.2 5119.6 4876.0 4945.2 4977.5 5012.3 5022.3 4957.3 4986.4 4986.5 4989.3 5023.4 4931.6 4953.9 4966.8 4979.0 5013.2 5272.2 5313.9 5360.4 5394.5 5413.1 5730.6 5737.2 5738.2 5741.7 5747.2 5786.7 5787.3 5787.3 5787.6 5796.7 5459.8 5496.1 5503.3 5514.2 5541.4 5806.8 5849.7 5855.2 5863.4 5866.5 5585.3 5622.3 5628.9 5629.0 5632.1 5801.5 5831.9 5836.2 5839.9 5890.8 5756.9 5757.2 5784.8 5791.1 5844.3 5706.8 5720.0 5740.6 5756.9 5769.8 4387.2 4392.5 4394.2 4423.8 4428.2 3902.3 3909.4 3916.1 3935.7 3938.7 5398.7 5432.2 5534.4 5553.1 5554.8 5734.5 5769.4 5776.0 5783.7 5829.2 5509.3 5519.4 5525.4 5528.9 5531.3 4861.3 4941.2 4957.9 4970.6 5002.5 6050.7 6051.6 6068.6 6071.9 6075.9 5798.7 5803.4 5859.6 5863.7 5872.1 5919.2 5922.5 5973.5 6002.8 6016.6 5686.5 5703.5 5705.9 5719.1 5728.5 5757.1 5773.1 5776.8 5810.6 5821.5 5585.8 5644.4 5685.8 5690.5 5698.9 5625.4 5718.4 5721.1 5725.2 5786.8 5554.9 5558.8 5582.8 5595.2 5609.2 5585.9 5728.1 5728.3 5755.7 5801.4 5580.6 5606.6 5613.4 5621.2 5630.4 02:28:01 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | [#1] ext.html Cycles:180 Average:49145.07 Median:37377.53 stddev:90000.02 (240.8%) stddev-sans-first:90178.64 02:28:01 INFO - PROCESS | 10626 | Values: 583.0 632.5 661.9 665.6 688.3 34691.7 35948.1 35988.8 36109.1 36183.3 35981.1 36365.0 36428.0 36582.3 36586.3 8299.5 8384.2 8430.5 8466.2 8498.1 8354.5 8622.5 8656.7 8676.7 8699.0 8674.6 8700.0 8721.7 8723.0 8743.1 8452.5 8630.0 8637.6 8639.4 8665.2 8613.9 8742.3 8749.7 8781.1 8802.8 31519.4 36824.6 37360.3 37394.8 37435.8 3199.8 3318.1 3433.2 3742.5 4023.1 26126.0 26936.5 26956.9 27016.6 31065.4 4006.3 4060.4 4108.7 4128.0 4212.9 205485.0 207780.0 208738.0 208788.0 208944.0 52500.7 52717.7 52842.0 52846.7 52853.0 62457.4 63598.4 63681.7 64465.7 64607.4 15242.1 15304.5 15317.0 15325.4 15473.8 12908.4 13079.7 13089.1 13103.3 13179.4 18439.7 18568.4 18746.7 19487.5 19553.0 6970.9 7270.9 7330.0 7422.5 7431.7 1009.3 1067.9 1144.4 1152.3 1173.1 30133.4 30622.8 31258.0 31381.8 31749.5 1173.8 1214.0 1217.9 1246.6 1278.7 16210.0 16220.5 16300.2 16559.3 16831.4 453195.0 458267.0 459894.0 460524.0 461788.0 54925.0 55694.0 55723.0 56018.7 56043.7 1369.1 1399.3 1412.0 1418.6 1514.8 30370.7 30647.7 30699.7 31045.5 31200.5 48396.5 48921.3 48931.8 49134.8 49380.0 303437.0 304876.0 306211.0 306611.0 306811.0 27258.6 27297.9 27822.7 27844.7 27865.6 46477.5 46619.3 46977.0 47239.3 47337.8 38416.4 39744.6 39980.4 40224.8 40250.6 38042.6 38558.8 39481.2 40072.6 40369.6 39885.6 39915.0 40283.4 41476.6 41668.8 31079.4 31271.2 31753.0 32191.8 32210.4 25414.0 25735.9 26109.9 26254.6 26297.1 02:28:01 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | [#2] jquery.html Cycles:180 Average:27120.75 Median:2704.97 stddev:76574.61 (2830.9%) stddev-sans-first:76763.13 02:28:01 INFO - PROCESS | 10626 | Values: 392.5 394.8 400.8 406.9 412.4 13586.5 17424.2 18091.4 18134.7 18197.7 14664.3 16970.6 17389.4 17723.8 17787.6 4982.7 5493.9 5556.2 5560.0 5560.2 5475.5 5653.2 5667.3 5731.1 5745.9 5634.3 5650.8 5659.9 5740.9 5750.3 5481.3 5661.0 5662.1 5697.0 5713.7 5005.9 5019.4 5037.3 5053.5 5063.2 20708.4 21010.9 21034.7 21601.9 21678.0 2235.9 2408.4 2488.3 2702.7 2707.2 13288.5 13680.5 13788.7 13945.7 14013.8 1948.6 1995.2 2003.0 2006.5 2015.1 70713.6 71104.3 71253.6 71742.3 76808.6 10305.4 10403.0 10548.9 10598.4 10731.5 14629.0 14844.9 14850.6 14945.3 14958.2 7252.9 7530.7 7770.1 8001.4 8118.8 7667.8 7677.7 7739.3 7774.0 7877.2 4494.8 4517.4 4568.8 4570.8 4660.4 1882.3 1910.2 1971.6 1985.0 1996.7 968.4 996.1 1008.7 1103.8 1120.2 17637.6 17794.9 17949.9 18407.8 18614.3 1018.8 1026.2 1045.6 1074.7 1086.5 9907.9 10066.7 10147.7 10269.8 10333.7 444406.0 468409.0 469751.0 470831.0 471361.0 88188.0 88226.0 88683.1 88690.6 89135.0 1052.8 1053.8 1056.4 1058.5 1073.2 15772.7 15774.4 15802.6 15897.4 15975.5 35300.6 35627.3 35994.5 36471.3 36836.4 47864.8 49717.3 49954.5 50774.0 50821.5 7239.2 7424.0 7781.2 7868.9 8008.2 7291.9 9672.5 11973.3 12328.8 12571.3 11136.3 11205.7 11395.8 11426.7 11477.3 10939.6 11143.7 11229.7 11254.2 11281.0 5729.1 6884.0 11286.9 11476.3 11587.8 7274.2 7388.9 7415.5 7491.3 7664.6 9934.6 11052.3 11201.4 11281.4 11376.2 02:28:01 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | [#3] mootools.html Cycles:180 Average:5631.66 Median:4922.42 stddev:3203.65 (65.1%) stddev-sans-first:3197.36 02:28:01 INFO - PROCESS | 10626 | Values: 1468.7 1497.1 1601.7 1686.1 1729.6 7632.7 8351.2 8375.8 8634.3 8666.0 8463.2 8481.0 8515.8 8532.2 8547.2 2242.0 2248.6 2263.9 2264.9 2279.7 2251.9 2256.6 2282.5 2296.1 2296.7 2194.8 2207.7 2208.0 2216.2 2247.4 2241.7 2256.8 2257.6 2260.1 2263.6 2191.6 2193.7 2194.8 2202.5 2204.5 8512.1 8676.5 8728.7 8738.9 8750.6 4918.4 5027.2 5056.2 5065.6 5077.5 3076.6 3137.5 3137.6 3181.6 3190.1 980.7 1005.8 1007.2 1007.8 1016.9 11474.9 11514.8 11535.3 11541.5 11618.1 4106.6 4124.5 4292.8 4322.7 4387.6 9206.8 9211.0 9212.2 9239.4 9265.2 5021.1 5037.8 5040.0 5057.5 5069.2 4218.3 4575.3 4666.5 4679.8 4714.8 3857.7 3879.4 3953.1 3979.8 4002.2 1266.0 1266.1 1289.4 1294.9 1302.4 695.1 768.5 790.2 860.3 906.6 5827.1 6098.0 6141.6 6219.4 6273.3 950.7 981.4 1006.5 1015.8 1018.2 4014.4 4106.3 4108.1 4148.9 4161.6 10465.9 10949.5 10979.1 11069.1 11091.9 10844.0 10882.2 10901.4 10958.3 10966.9 8069.8 8179.1 8206.1 8227.3 8234.5 5824.8 5841.0 5960.2 6062.6 6080.2 9726.6 9857.9 10087.0 10114.3 10178.4 10059.2 10122.9 10189.4 10191.3 10464.2 6831.9 7461.3 7472.3 7536.9 7671.2 7895.6 7900.4 7964.7 7980.0 8030.2 7287.9 7395.6 7649.8 7713.2 7720.5 7249.5 7413.5 7422.6 7475.0 7488.5 6817.9 6873.8 6898.0 6905.8 6924.6 4926.4 4950.8 4971.7 5051.2 5162.6 4941.2 4942.7 4997.0 5026.3 5145.9 02:28:01 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | [#4] prototype.html Cycles:180 Average:5290.01 Median:6098.41 stddev:1610.35 (26.4%) stddev-sans-first:1571.11 02:28:01 INFO - PROCESS | 10626 | Values: 322.5 332.7 339.8 341.1 343.8 5837.2 5943.9 5985.3 6109.7 6172.2 6007.8 6008.2 6016.9 6025.0 6049.5 4608.6 4613.6 4616.9 4620.8 4625.5 4482.0 4600.2 4609.5 4611.3 4616.0 4510.3 4527.0 4541.4 4550.4 4561.8 4535.3 4535.9 4550.2 4556.8 4562.1 3735.4 3943.6 3945.7 4014.6 4018.1 5719.5 5726.7 5743.3 5763.3 5812.2 5136.3 5183.3 5213.2 5221.8 5234.4 5992.0 6190.1 6255.9 6335.5 6354.5 4310.6 4314.1 4316.3 4320.2 4320.9 6288.5 6489.7 6537.8 6561.9 6591.1 4412.3 4436.2 4446.9 4459.6 4461.3 4509.3 4509.7 4511.3 4514.3 4517.1 4980.1 5171.9 5186.9 5227.8 5231.9 6137.9 6319.2 6320.2 6424.9 6427.5 1549.6 1566.4 1570.4 1572.5 1574.6 972.5 1001.5 1005.6 1023.1 1031.4 6114.9 6121.0 6121.6 6161.9 6163.9 6483.5 6528.8 6540.0 6560.2 6586.5 6022.1 6084.9 6094.9 6101.9 6137.3 3496.6 3512.4 3519.0 3543.6 3545.1 6665.9 6740.7 6764.2 6775.7 6790.9 6681.2 6693.4 6706.1 6710.2 6723.5 6555.7 6750.5 6800.4 6808.4 6809.4 6489.8 6500.3 6528.2 6528.8 6532.6 6243.6 6416.2 6425.2 6448.8 6456.4 6731.0 6756.3 6756.6 6774.5 6781.4 4371.4 4393.6 4425.6 4449.0 4460.1 6331.9 6408.0 6502.5 6524.4 6595.4 6399.9 6408.8 6426.4 6432.2 6436.3 6217.8 6406.0 6418.1 6424.1 6424.7 6291.7 6301.1 6305.4 6308.7 6341.0 6450.8 6455.8 6457.0 6487.5 6502.5 6104.4 6240.4 6253.1 6258.2 6266.5 02:28:01 INFO - PROCESS | 10626 | 02:28:01 INFO - PROCESS | 10626 | [#5] yui.html Cycles:180 Average:13977.89 Median:4375.40 stddev:15793.96 (361.0%) stddev-sans-first:15806.93 02:28:01 INFO - PROCESS | 10626 | Values: 728.9 736.9 749.3 753.2 867.3 14011.8 14555.2 14658.2 14668.6 14697.9 13454.1 13513.7 13567.7 13671.7 13687.3 801.1 819.3 826.5 832.1 835.3 830.2 830.6 831.8 833.0 835.8 853.4 853.5 858.3 859.4 865.9 849.1 852.5 854.0 858.9 862.1 614.9 615.0 624.5 626.3 629.0 13123.5 13174.3 13202.7 13217.1 13229.5 13519.1 13611.0 13643.4 13712.7 13742.4 10928.9 10931.6 10974.8 11114.3 11227.4 3656.2 3677.6 3704.1 3828.5 3865.4 53135.7 53324.5 53761.0 53792.7 54289.7 10393.6 10510.7 10528.4 10625.1 10742.9 19134.2 19290.2 19322.3 19332.6 19333.2 7840.2 7920.5 7922.5 7998.4 8043.9 4506.1 4705.7 4740.6 4756.7 4784.6 3135.0 3205.8 3232.8 3237.9 3245.4 528.6 545.5 551.7 568.7 573.0 632.6 753.9 754.3 757.0 775.7 7715.5 8259.1 8615.3 8735.7 9034.4 716.0 724.1 734.6 743.6 745.5 4187.2 4348.5 4361.6 4389.2 4475.8 55706.0 55721.0 56706.7 57222.7 57356.1 50796.0 50950.2 51182.2 51424.5 51460.0 46200.5 46420.5 46574.8 46685.5 46999.8 8215.3 8569.7 8570.9 8579.9 8731.6 29831.3 30172.8 30543.5 30651.5 31173.0 38773.6 39205.8 39373.6 39760.0 41106.8 12103.8 12329.7 12415.5 12446.6 12472.5 12576.9 12689.7 13149.9 13196.9 13220.9 12047.9 12253.6 12507.2 12671.0 12861.4 11974.0 12260.8 12275.2 12279.2 12484.4 10377.6 11159.3 11278.6 11323.8 11834.2 9973.5 10006.8 10154.7 10472.4 10561.4 9896.4 10065.9 10081.2 10262.5 10309.1 02:28:01 INFO - PROCESS | 10626 | -------- Summary: end -------- 02:28:01 INFO - PROCESS | 10626 | 02:28:02 INFO - TEST-INFO | 10626: exit 0 02:28:02 INFO - TEST-OK | dromaeo_css | took 1109545ms 02:28:02 INFO - TEST-START | kraken 02:28:02 INFO - operating with platform_type : linux_ 02:28:02 INFO - Initialising browser for kraken test... 02:28:02 INFO - TEST-INFO | started process 10864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJSfi47/profile http://localhost:54268/getInfo.html) 02:28:05 INFO - PROCESS | 10864 | 02:28:05 INFO - PROCESS | 10864 | (process:10932): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:28:06 INFO - PROCESS | 10864 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 02:28:06 INFO - PROCESS | 10864 | __metrics Screen width/height:1600/1200 02:28:06 INFO - PROCESS | 10864 | colorDepth:24 02:28:06 INFO - PROCESS | 10864 | Browser inner width/height: 1024/697 02:28:06 INFO - PROCESS | 10864 | __metrics 02:28:07 ERROR - PROCESS | 10864 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:28:08 INFO - TEST-INFO | 10864: exit 0 02:28:08 INFO - Browser initialized. 02:28:08 INFO - Running cycle 1/1 for kraken test... 02:28:08 INFO - TEST-INFO | started process 10983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJSfi47/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:09 INFO - PROCESS | 10983 | 02:28:09 INFO - PROCESS | 10983 | (process:11043): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:28:19 INFO - PROCESS | 10983 | RSS: Main: 163377152 02:28:19 INFO - PROCESS | 10983 | 02:28:22 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54268/tests/kraken/driver.html?testName=audio-beat-detection) 02:28:23 INFO - PROCESS | 10983 | RSS: Main: 168148992 02:28:23 INFO - PROCESS | 10983 | 02:28:25 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54268/tests/kraken/driver.html?testName=audio-dft) 02:28:26 INFO - PROCESS | 10983 | RSS: Main: 171958272 02:28:26 INFO - PROCESS | 10983 | 02:28:29 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54268/tests/kraken/driver.html?testName=audio-fft) 02:28:30 INFO - PROCESS | 10983 | RSS: Main: 162504704 02:28:30 INFO - PROCESS | 10983 | 02:28:32 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54268/tests/kraken/driver.html?testName=audio-oscillator) 02:28:32 INFO - PROCESS | 10983 | RSS: Main: 162885632 02:28:32 INFO - PROCESS | 10983 | 02:28:35 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:28:35 INFO - PROCESS | 10983 | RSS: Main: 163745792 02:28:35 INFO - PROCESS | 10983 | 02:28:38 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54268/tests/kraken/driver.html?testName=imaging-darkroom) 02:28:39 INFO - PROCESS | 10983 | RSS: Main: 163377152 02:28:39 INFO - PROCESS | 10983 | 02:28:42 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54268/tests/kraken/driver.html?testName=imaging-desaturate) 02:28:43 INFO - PROCESS | 10983 | RSS: Main: 162979840 02:28:43 INFO - PROCESS | 10983 | 02:28:46 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54268/tests/kraken/driver.html?testName=json-parse-financial) 02:28:46 INFO - PROCESS | 10983 | RSS: Main: 164446208 02:28:46 INFO - PROCESS | 10983 | 02:28:48 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:28:49 INFO - PROCESS | 10983 | RSS: Main: 164356096 02:28:49 INFO - PROCESS | 10983 | 02:28:50 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54268/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:28:51 INFO - PROCESS | 10983 | RSS: Main: 164274176 02:28:51 INFO - PROCESS | 10983 | 02:28:53 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:28:54 INFO - PROCESS | 10983 | RSS: Main: 164737024 02:28:54 INFO - PROCESS | 10983 | 02:28:56 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:28:57 INFO - PROCESS | 10983 | RSS: Main: 165175296 02:28:57 INFO - PROCESS | 10983 | 02:29:00 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:29:01 INFO - PROCESS | 10983 | RSS: Main: 165523456 02:29:01 INFO - PROCESS | 10983 | 02:29:02 INFO - PROCESS | 10983 | Cycle 1(1): loaded http://localhost:54268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54268/tests/kraken/driver.html?testName=ai-astar) 02:29:03 INFO - PROCESS | 10983 | RSS: Main: 166481920 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | __start_tp_report 02:29:03 INFO - PROCESS | 10983 | _x_x_mozilla_page_load 02:29:03 INFO - PROCESS | 10983 | _x_x_mozilla_page_load_details 02:29:03 INFO - PROCESS | 10983 | |i|pagename|runs| 02:29:03 INFO - PROCESS | 10983 | |0;ai-astar;111;107;113;115;110;125;112;123;114;112 02:29:03 INFO - PROCESS | 10983 | |1;audio-beat-detection;160;129;153;187;126;154;149;136;186;132 02:29:03 INFO - PROCESS | 10983 | |2;audio-dft;163;163;163;166;163;165;173;165;165;163 02:29:03 INFO - PROCESS | 10983 | |3;audio-fft;75;77;78;172;76;81;73;81;175;77 02:29:03 INFO - PROCESS | 10983 | |4;audio-oscillator;92;92;157;91;93;92;149;94;93;144 02:29:03 INFO - PROCESS | 10983 | |5;imaging-gaussian-blur;118;118;118;118;117;118;117;118;120;118 02:29:03 INFO - PROCESS | 10983 | |6;imaging-darkroom;148;147;147;146;147;146;146;147;148;147 02:29:03 INFO - PROCESS | 10983 | |7;imaging-desaturate;96;95;95;103;95;95;95;96;95;95 02:29:03 INFO - PROCESS | 10983 | |8;json-parse-financial;58;60;62;60;60;59;59;80;57;56 02:29:03 INFO - PROCESS | 10983 | |9;json-stringify-tinderbox;64;63;62;61;62;62;61;62;62;62 02:29:03 INFO - PROCESS | 10983 | |10;stanford-crypto-aes;74;83;77;77;77;79;78;79;79;78 02:29:03 INFO - PROCESS | 10983 | |11;stanford-crypto-ccm;133;131;127;127;130;139;133;122;172;139 02:29:03 INFO - PROCESS | 10983 | |12;stanford-crypto-pbkdf2;176;175;168;171;171;180;167;170;171;169 02:29:03 INFO - PROCESS | 10983 | |13;stanford-crypto-sha256-iterative;72;74;77;72;71;69;71;68;72;71 02:29:03 INFO - PROCESS | 10983 | __end_tp_report 02:29:03 INFO - PROCESS | 10983 | __start_cc_report 02:29:03 INFO - PROCESS | 10983 | _x_x_mozilla_cycle_collect,856 02:29:03 INFO - PROCESS | 10983 | __end_cc_report 02:29:03 INFO - PROCESS | 10983 | __startTimestamp1460971743018__endTimestamp 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | ------- Summary: start ------- 02:29:03 INFO - PROCESS | 10983 | Number of tests: 14 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#0] ai-astar Cycles:10 Average:114.20 Median:113.50 stddev:5.63 (5.0%) stddev-sans-first:5.85 02:29:03 INFO - PROCESS | 10983 | Values: 111.0 107.0 113.0 115.0 110.0 125.0 112.0 123.0 114.0 112.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:153.50 stddev:21.89 (14.3%) stddev-sans-first:22.99 02:29:03 INFO - PROCESS | 10983 | Values: 160.0 129.0 153.0 187.0 126.0 154.0 149.0 136.0 186.0 132.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:3.07 (1.9%) stddev-sans-first:3.18 02:29:03 INFO - PROCESS | 10983 | Values: 163.0 163.0 163.0 166.0 163.0 165.0 173.0 165.0 165.0 163.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#3] audio-fft Cycles:10 Average:96.50 Median:77.00 stddev:40.66 (52.8%) stddev-sans-first:42.38 02:29:03 INFO - PROCESS | 10983 | Values: 75.0 77.0 78.0 172.0 76.0 81.0 73.0 81.0 175.0 77.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.00 stddev:27.99 (30.4%) stddev-sans-first:28.95 02:29:03 INFO - PROCESS | 10983 | Values: 92.0 92.0 157.0 91.0 93.0 92.0 149.0 94.0 93.0 144.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 02:29:03 INFO - PROCESS | 10983 | Values: 118.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 120.0 118.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 02:29:03 INFO - PROCESS | 10983 | Values: 148.0 147.0 147.0 146.0 147.0 146.0 146.0 147.0 148.0 147.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:2.49 (2.6%) stddev-sans-first:2.65 02:29:03 INFO - PROCESS | 10983 | Values: 96.0 95.0 95.0 103.0 95.0 95.0 95.0 96.0 95.0 95.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.00 stddev:6.85 (11.4%) stddev-sans-first:7.18 02:29:03 INFO - PROCESS | 10983 | Values: 58.0 60.0 62.0 60.0 60.0 59.0 59.0 80.0 57.0 56.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.60 02:29:03 INFO - PROCESS | 10983 | Values: 64.0 63.0 62.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.50 stddev:2.28 (2.9%) stddev-sans-first:1.88 02:29:03 INFO - PROCESS | 10983 | Values: 74.0 83.0 77.0 77.0 77.0 79.0 78.0 79.0 79.0 78.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:133.00 stddev:13.93 (10.5%) stddev-sans-first:14.75 02:29:03 INFO - PROCESS | 10983 | Values: 133.0 131.0 127.0 127.0 130.0 139.0 133.0 122.0 172.0 139.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:171.00 stddev:4.02 (2.4%) stddev-sans-first:3.97 02:29:03 INFO - PROCESS | 10983 | Values: 176.0 175.0 168.0 171.0 171.0 180.0 167.0 170.0 171.0 169.0 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - PROCESS | 10983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:72.00 stddev:2.50 (3.5%) stddev-sans-first:2.65 02:29:03 INFO - PROCESS | 10983 | Values: 72.0 74.0 77.0 72.0 71.0 69.0 71.0 68.0 72.0 71.0 02:29:03 INFO - PROCESS | 10983 | -------- Summary: end -------- 02:29:03 INFO - PROCESS | 10983 | 02:29:03 INFO - TEST-INFO | 10983: exit 0 02:29:03 INFO - TEST-OK | kraken | took 61545ms 02:29:03 INFO - SUITE-END | took 1171s 02:29:04 INFO - Completed test suite (00:19:31) 02:29:04 INFO - javascript benchmark 02:29:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.8897538586148, 3173.2542852429688, 3175.1268401189677, 3217.9517307240394, 3222.452183128868, 5420.241166236725, 5449.318835145602, 5479.342478902532, 5485.204645326436, 5502.0921547944645, 5416.322959630046, 5442.455754424565, 5454.127339625661, 5459.099248623972, 5557.916631250535, 4923.753812309379, 4974.403071631409, 4978.0, 5043.470435604264, 5094.490550944913, 5032.874178145557, 5039.44566097729, 5081.314022606938, 5096.159133742928, 5119.641625086246, 4875.951240487603, 4945.208766597345, 4977.477364876672, 5012.273220383042, 5022.347094877642, 4957.256411538262, 4986.4265609455015, 4986.526280003394, 4989.301497790312, 5023.422306434733, 4931.580815630676, 4953.900921981576, 4966.826161084381, 4979.029089327582, 5013.222950442687, 5272.209168624699, 5313.920291195635, 5360.437154098802, 5394.514493695547, 5413.106837371868, 5730.598858079936, 5737.168110623978, 5738.167965645, 5741.712914354265, 5747.1666608341975, 5786.68173250471, 5787.276590426197, 5787.276590426197, 5787.623804452697, 5796.681182534959, 5459.781608735646, 5496.148097044925, 5503.3395992481155, 5514.228008078872, 5541.362743284533, 5806.82579522615, 5849.707514624251, 5855.151003104526, 5863.442972917651, 5866.472017518444, 5585.301837270341, 5622.269105016404, 5628.85927851807, 5629.043062679354, 5632.127020311858, 5801.477866991991, 5831.854203644943, 5836.212111364996, 5839.9124013139835, 5890.823275301748, 5756.856078597984, 5757.193992841006, 5784.82645520635, 5791.0734282514595, 5844.26946631671, 5706.828795136153, 5720.0, 5740.56945729072, 5756.884862302814, 5769.826905192851, 4387.232234359039, 4392.450943632046, 4394.187075390999, 4423.778811059434, 4428.247197976351, 3902.317094508506, 3909.3745000799736, 3916.060145565101, 3935.685145188378, 3938.6849052076336, 5398.73006349681, 5432.239486471897, 5534.418886016991, 5553.08374118266, 5554.750036248379, 5734.5125664319, 5769.423057694281, 5776.0, 5783.739731712083, 5829.183914252008, 5509.311336082989, 5519.420460851633, 5525.392206857243, 5528.889422211533, 5531.253280807039, 4861.29511220871, 4941.234108713155, 4957.851264462072, 4970.552650261494, 5002.474740152232, 6050.6974651267265, 6051.576389652682, 6068.605540639845, 6071.908921366183, 6075.908861367083, 5798.710064496674, 5803.448672376117, 5859.648421094748, 5863.677497737665, 5872.0898260769645, 5919.230500034968, 5922.466977972003, 5973.522118230618, 6002.789902353396, 6016.639001659914, 5686.545076393796, 5703.543716502587, 5705.885882282248, 5719.084946408555, 5728.513076388554, 5757.0788673811985, 5773.076307790733, 5776.797812076557, 5810.593258471867, 5821.534277257894, 5585.804496842591, 5644.435556444323, 5685.800996965252, 5690.459406356389, 5698.886022279614, 5625.409332020079, 5718.370979192368, 5721.141828725725, 5725.16985037159, 5786.797462088806, 5554.888902221852, 5558.805441809517, 5582.804601838916, 5595.244641973281, 5609.21470994053, 5585.944140558705, 5728.054870946247, 5728.255326807488, 5755.65466072037, 5801.36185019639, 5580.609357344947, 5606.607537472338, 5613.410591887956, 5621.156826476062, 5630.380658127685], "value": 5355.764229273309, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.9708514574273, 632.4908448698801, 661.9304972977837, 665.5707068940534, 688.284184448174, 34691.65308346916, 35948.10129746755, 35988.82005589972, 36109.097272568135, 36183.276334473296, 35981.1004724882, 36365.0, 36428.0, 36582.26835463289, 36586.268274634494, 8299.502029878211, 8384.245417912387, 8430.452020618672, 8466.153384661515, 8498.107698691641, 8354.540500272513, 8622.482651040958, 8656.740297791077, 8676.739697809044, 8698.956505217466, 8674.609642566069, 8700.0, 8721.694740684077, 8722.956385218065, 8743.12568743127, 8452.535110568917, 8630.0, 8637.611307491177, 8639.43843650167, 8665.176808203274, 8613.913860861374, 8742.256908162813, 8749.693760718408, 8781.121887811232, 8802.779930501725, 31519.36961260785, 36824.63175368239, 37360.25279494422, 37394.813025934694, 37435.812820935724, 3199.84159200041, 3318.1206980150278, 3433.2446861690387, 3742.4760533525327, 4023.0746928206677, 26126.0, 26936.461270774475, 26956.86521567399, 27016.59475107875, 31065.378692426024, 4006.258842114218, 4060.4315395844606, 4108.650764685005, 4128.0, 4212.936805947913, 205485.0, 207780.0, 208738.0, 208788.0, 208944.0, 52500.73749631227, 52717.73641131847, 52842.0, 52846.735766320926, 52853.0, 62457.375426246064, 63598.36401636017, 63681.68159159175, 64465.67767161134, 64607.35392646107, 15242.085474871543, 15304.464343747915, 15317.0, 15325.386984520494, 15473.767893481607, 12908.35458227085, 13079.738405231841, 13089.149205301625, 13103.27931963732, 13179.406926688322, 18439.72340414895, 18568.350107746162, 18746.718799218022, 19487.512812179808, 19553.0223488825, 6970.860582788316, 7270.927290727131, 7330.010448589373, 7422.517536360119, 7431.665575049135, 1009.2733232072895, 1067.8611780468489, 1144.3837473583603, 1152.2798251093068, 1173.1494666366987, 30133.397332053235, 30622.846885765874, 31258.0, 31381.843090784856, 31749.523757143663, 1173.8297946797666, 1213.990845151276, 1217.9025677945742, 1246.6010876519426, 1278.7442511497738, 16210.027398356136, 16220.51338459848, 16300.184990750415, 16559.337626495046, 16831.410900618663, 453195.0, 458267.0, 459894.0, 460524.0, 461788.0, 54925.0, 55694.0, 55723.0, 56018.719906400205, 56043.71978140083, 1369.1442848219863, 1399.3353157250224, 1412.039812927199, 1418.6240646228757, 1514.8409417011276, 30370.696293036788, 30647.693523065376, 30699.693003069682, 31045.534316985715, 31200.531992019685, 48396.5160348392, 48921.2661810066, 48931.75534122306, 49134.75432622814, 49380.0, 303437.0, 304876.0, 306211.0, 306611.0, 306811.0, 27258.591121132802, 27297.86351068232, 27822.721772782013, 27844.721552785024, 27865.58201627018, 46477.53522464732, 46619.30071048869, 46977.0, 47239.29141062818, 47337.7633111846, 38416.42375364316, 39744.602553975245, 39980.400293996194, 40224.798876005436, 40250.59749402585, 38042.61957380391, 38558.80720596491, 39481.2103757929, 40072.59927400688, 40369.59630403658, 39885.60114398819, 39915.0, 40283.3957490632, 41476.58523414848, 41668.791656041525, 31079.378412432077, 31271.218219544695, 31753.0, 32191.839040804647, 32210.35579288448, 25414.0, 25735.871320643277, 26109.869450652626, 26254.606180907685, 26297.079602214595], "value": 18892.44211484902, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.51524367406256, 394.8203567376844, 400.76755481820544, 406.94913135858036, 412.36084069691987, 13586.535433464478, 17424.215910284034, 18091.366802161927, 18134.727979080326, 18197.72703409448, 14664.340104695288, 16970.575735606584, 17389.39137130201, 17723.82276177241, 17787.64424711505, 4982.651214414992, 5493.945060549383, 5556.194351818984, 5560.0, 5560.2493663355535, 5475.4524547545125, 5653.208550802891, 5667.263255776743, 5731.111677689964, 5745.942540574582, 5634.295713035871, 5650.773969041254, 5659.943400565983, 5740.913886291709, 5750.33871104822, 5481.342238931354, 5661.0, 5662.094064949609, 5697.003024470721, 5713.74288157034, 5005.874853128665, 5019.42276638184, 5037.29477873098, 5053.519915608012, 5063.1898896176435, 20708.378748637566, 21010.894945525175, 21034.684479732816, 21601.891990540105, 21678.0, 2235.944101397462, 2408.446057406789, 2488.32815139913, 2702.702702702701, 2707.241972247774, 13288.468461261538, 13680.52118175869, 13788.724225515534, 13945.721085578332, 14013.789793153112, 1948.5713143108494, 1995.1919472613615, 2002.9899850500653, 2006.518435575466, 2015.133492598182, 70713.64643176802, 71104.2889571108, 71253.64373178153, 71742.28257717408, 76808.61595691986, 10305.433201173857, 10403.0, 10548.947255263674, 10598.417087060132, 10731.463426828628, 14629.0, 14844.851551484348, 14850.628734281514, 14945.252737363306, 14958.177300248373, 7252.927470725225, 7530.6611202496015, 7770.106437759617, 8001.399895007898, 8118.75643730689, 7667.808304792425, 7677.731279405194, 7739.264769846855, 7773.961130194426, 7877.172896845863, 4494.820207191676, 4517.435320584927, 4568.81724731007, 4570.771461426915, 4660.370849935283, 1882.2941396976134, 1910.169076451748, 1971.5804620673093, 1985.0471773548777, 1996.7204591357222, 968.3850754770772, 996.0985308296003, 1008.7487464740683, 1103.812351900179, 1120.2494328799723, 17637.559061023578, 17794.91545558926, 17949.871079930264, 18407.815921840876, 18614.34849780251, 1018.8013337399284, 1026.1585499890018, 1045.592219034577, 1074.6507385099874, 1086.473060565625, 9907.851382229272, 10066.748331291776, 10147.660381123387, 10269.794604108025, 10333.74165645865, 444406.0, 468409.0, 469751.0, 470831.0, 471361.0, 88188.0, 88226.0, 88683.11316886877, 88690.55654721815, 89135.0, 1052.7736536644659, 1053.8050460664801, 1056.4242487844144, 1058.4760543531002, 1073.2272763610188, 15772.68454630924, 15774.447894323643, 15802.60493487672, 15897.364105435652, 15975.520734377988, 35300.646993529735, 35627.28745425129, 35994.4600830993, 36471.27057458889, 36836.44745328876, 47864.7606761964, 49717.254241185685, 49954.500454996436, 50774.0, 50821.49178508168, 7239.239879812544, 7423.962880185781, 7781.182975787688, 7868.8819667706175, 8008.239217274349, 7291.8541629168185, 9672.516374181121, 11973.341466219441, 12328.81506777381, 12571.308578028296, 11136.276142050741, 11205.719857003314, 11395.772084558428, 11426.657200284004, 11477.253978491372, 10939.56241750321, 11143.72140696489, 11229.71925701864, 11254.21220514556, 11281.0, 5729.083346664514, 6884.0, 11286.887131128584, 11476.270212181242, 11587.768244635228, 7274.16347120088, 7388.889166662612, 7415.5179913305465, 7491.250874912465, 7664.616769161631, 9934.552945117342, 11052.336859788438, 11201.383923884265, 11281.379524126252, 11376.203665743318], "value": 8801.918369404191, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.7429699802533, 1497.0867770659895, 1601.6876709041735, 1686.1316422042657, 1729.6108375615481, 7632.656530456129, 8351.248387645112, 8375.832483350345, 8634.309255259579, 8665.956670216656, 8463.153684631534, 8480.95759521203, 8515.78710532237, 8532.23209911108, 8547.230749232567, 2242.0471299697606, 2248.5952528544935, 2263.879379707039, 2264.852784568998, 2279.7150356205475, 2251.8536295140843, 2256.571251462225, 2282.486440550871, 2296.127471560813, 2296.678465014891, 2194.7585765565773, 2207.6909232707435, 2208.0, 2216.2243214874748, 2247.4269061389405, 2241.663750437431, 2256.7743225677464, 2257.571061498318, 2260.08466571039, 2263.5586060718165, 2191.638379667353, 2193.6599827026835, 2194.8353873459555, 2202.4714068623575, 2204.4599073227164, 8512.1487851215, 8676.479411235347, 8728.650853965833, 8738.912610873873, 8750.606222719993, 4918.409790825124, 5027.170516864713, 5056.165732654108, 5065.569426598743, 5077.517635824628, 3076.615423072116, 3137.4823154179535, 3137.5607414961923, 3181.6341120771176, 3190.1067701043744, 980.6616717232544, 1005.7636455432968, 1007.1590222164501, 1007.8437842134481, 1016.8881423043459, 11474.942625286903, 11514.769704605944, 11535.307881527135, 11541.480633371519, 11618.07055435563, 4106.609872062149, 4124.546299907008, 4292.806823692878, 4322.697411181187, 4387.561243875651, 9206.76983075415, 9211.0, 9212.216961558343, 9239.445633262027, 9265.212456941235, 5021.121303771825, 5037.823676171316, 5040.042391945519, 5057.519535644108, 5069.1635880079375, 4218.303979843353, 4575.3365761965, 4666.4633567139535, 4679.766011699401, 4714.834980775657, 3857.7492462989817, 3879.3792993120965, 3953.0512676957323, 3979.801009949491, 4002.15954649521, 1266.0441366768032, 1266.0757646917803, 1289.4390939941156, 1294.8834604885606, 1302.3813688497887, 695.1484431571284, 768.4889548450218, 790.1593770395419, 860.3418384935529, 906.6146887572887, 5827.096799996008, 6098.0, 6141.6007959482495, 6219.378062193744, 6273.309935907047, 950.7290422229631, 981.3572110267786, 1006.5319626373625, 1015.8476228565627, 1018.2108865629197, 4014.3577027675433, 4106.281400754856, 4108.096218831853, 4148.896277593084, 4161.583841615814, 10465.9476702616, 10949.4525273736, 10979.121670266359, 11069.05912997388, 11091.889081109086, 10844.024037836632, 10882.238243322892, 10901.400422976812, 10958.28771129874, 10966.890331096587, 8069.838603227902, 8179.059408168017, 8206.138355472709, 8227.300679442194, 8234.464759790595, 5824.767009319749, 5840.970795145997, 5960.195373624679, 6062.605930614496, 6080.179175811209, 9726.562304696447, 9857.901420985985, 10087.0, 10114.342567733074, 10178.389296642225, 10059.245556583139, 10122.949385253027, 10189.43958082283, 10191.286609937233, 10464.215183861088, 6831.863362732817, 7461.253874612496, 7472.327490525879, 7536.886946695914, 7671.156172821097, 7895.64469598858, 7900.4074694397, 7964.721234756756, 7979.9601001994615, 8030.156833532628, 7287.8542429152185, 7395.593242371721, 7649.808754781175, 7713.2286771322415, 7720.53676779395, 7249.528780629243, 7413.481056326005, 7422.628868556442, 7475.0, 7488.475806693479, 6817.897731533932, 6873.759418420332, 6898.0, 6905.827354316182, 6924.58452492852, 4926.433460151985, 4950.8267210647455, 4971.676841005467, 5051.217061355495, 5162.561182299396, 4941.209406494943, 4942.678725882806, 4997.0, 5026.3214466048075, 5145.948540514547], "value": 4494.835166073086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.46792791893387, 332.65736291619635, 339.7638641144404, 341.08248810699234, 343.7915726222329, 5837.182794408786, 5943.910841337383, 5985.25184351956, 6109.725062372193, 6172.228471441075, 6007.789727359544, 6008.218931538905, 6016.87966240676, 6024.9698751506185, 6049.485793707529, 4608.5621865922685, 4613.630909527246, 4616.930746038812, 4620.768961551926, 4625.537446255373, 4481.977590112045, 4600.217962946307, 4609.539046095397, 4611.262198048313, 4615.976920115411, 4510.345999830039, 4526.954730452702, 4541.409616749818, 4550.38569793077, 4561.840335588255, 4535.319702044687, 4535.909281814362, 4550.180967425862, 4556.794944227501, 4562.087582483517, 3735.4396840474146, 3943.645071943539, 3945.7237993340477, 4014.574825936809, 4018.1361007383553, 5719.485246327808, 5726.742296596663, 5743.310802703661, 5763.337216220147, 5812.157237200582, 5136.306598609177, 5183.326167598226, 5213.218017297398, 5221.843344699665, 5234.42421333653, 5991.970040149815, 6190.102435146879, 6255.906161407583, 6335.465813674521, 6354.523410744213, 4310.590493903074, 4314.094040251551, 4316.287812510964, 4320.200762858881, 4320.870373888788, 6288.496920246415, 6489.67551622417, 6537.771178008795, 6561.901571476432, 6591.143151390336, 4412.294032954712, 4436.157130145262, 4446.933296000562, 4459.55064604005, 4461.286194208911, 4509.255972764523, 4509.661775366861, 4511.300748384006, 4514.255147900625, 4517.073999830092, 4980.103581355391, 5171.922421163686, 5186.870328241824, 5227.817026404057, 5231.895362092737, 6137.877242455215, 6319.178506794087, 6320.178376811077, 6424.871502569922, 6427.485801135898, 1549.636320038359, 1566.4204244429634, 1570.4110958390604, 1572.4732214708201, 1574.559123445437, 972.4943029624555, 1001.5142655811925, 1005.5877090392904, 1023.0638965346625, 1031.3657100882904, 6114.908276375858, 6121.0, 6121.602095863755, 6161.938380616137, 6163.907541386883, 6483.546151769331, 6528.836779080561, 6540.0, 6560.179977502812, 6586.538942274091, 6022.096685497123, 6084.939150608438, 6094.908576371358, 6101.908471372933, 6137.263528376623, 3496.615372309044, 3512.4028915084496, 3518.9824050879583, 3543.6456354364873, 3545.1137215696076, 6665.933340666628, 6740.730370785212, 6764.188297404343, 6775.72897084121, 6790.932090679129, 6681.231658359254, 6693.397594216543, 6706.094677218611, 6710.16122984627, 6723.462123030145, 6555.704993275314, 6750.459963202932, 6800.353966373186, 6808.387245147861, 6809.421199198025, 6489.837754056186, 6500.349965003462, 6528.2492513359675, 6528.836779080561, 6532.575382600306, 6243.62742157977, 6416.197975253093, 6425.228972523327, 6448.774292899726, 6456.418922297016, 6731.038343129007, 6756.290589488033, 6756.560823546453, 6774.525783195129, 6781.3896749290825, 4371.409859668904, 4393.637972228619, 4425.579569940851, 4448.977755111204, 4460.107978404268, 6331.873362532816, 6408.0, 6502.512311576746, 6524.380183882524, 6595.406413422815, 6399.93600064012, 6408.839779005562, 6426.389492998158, 6432.163818703539, 6436.292007879036, 6217.782377616762, 6406.007068904327, 6418.133551970424, 6424.132742079946, 6424.710888009958, 6291.748330066746, 6301.117843502005, 6305.4009869062365, 6308.684565771785, 6341.0, 6450.838729031811, 6455.838604034937, 6457.0, 6487.545871789118, 6502.512311576746, 6104.359042300494, 6240.375962403723, 6253.124562561154, 6258.155149055002, 6266.496040950048], "value": 4760.480940247878, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.9416846652267, 736.9042024536809, 749.2544917806783, 753.2016062973249, 867.31482129118, 14011.789823152661, 14555.199464029474, 14658.193799341032, 14668.559943201708, 14697.92651036746, 13454.125481843674, 13513.662158446044, 13567.728645427085, 13671.658208544792, 13687.3156342183, 801.1187693537121, 819.2831272636458, 826.5330088499978, 832.0805509911521, 835.3150416658343, 830.2486249943811, 830.5805568188057, 831.7795784117213, 832.9875051874196, 835.8202986357932, 853.3940901959617, 853.4580541356221, 858.3390789092396, 859.3855393393723, 865.8701194820765, 849.142366210126, 852.4842470305468, 853.9701110461104, 858.9398742088056, 862.1163307609719, 614.8985417406167, 614.9938500614982, 624.5128799536369, 626.3266987987931, 628.9905651415187, 13123.540676076387, 13174.27541485218, 13202.735945281136, 13217.140885842486, 13229.536966206233, 13519.121257118355, 13611.0, 13643.38604762788, 13712.725745485035, 13742.381592828347, 10928.890711092947, 10931.620282573886, 10974.835377469344, 11114.277571957797, 11227.382493962828, 3656.1773600939578, 3677.5586929568353, 3704.111013356802, 3828.5022947016987, 3865.4201869719486, 53135.734321328535, 53324.46675533272, 53761.0, 53792.731036344565, 54289.72855135739, 10393.58425662965, 10510.684679459628, 10528.420936848393, 10625.149988000941, 10742.892571074346, 19134.234630614897, 19290.22839086449, 19322.32371866978, 19332.613347732968, 19333.226670933003, 7840.215978402114, 7920.485168464032, 7922.524648521107, 7998.402914680731, 8043.919560804317, 4506.098780243964, 4705.717656940595, 4740.620750339965, 4756.6670333077045, 4784.617230621611, 3134.9686503134676, 3205.759568032407, 3232.8060316381093, 3237.8866739664, 3245.432049391347, 528.6141116984622, 545.5390195285057, 551.6827824001135, 568.687222027883, 572.9713514324267, 632.6046221111806, 753.8831481120435, 754.2608243920988, 756.9507981981153, 775.7478819383723, 7715.498492597963, 8259.091499935003, 8615.310775137974, 8735.737927862174, 9034.412763170372, 715.9749408770668, 724.1129616220088, 734.5959722152794, 743.5687301365303, 745.4744405194325, 4187.20443115807, 4348.5216626171095, 4361.5856493633055, 4389.217057233995, 4475.7985890635, 55706.0, 55721.0, 56706.71646641823, 57222.7138864303, 57356.139657905165, 50796.0, 50950.23574646383, 51182.23226651529, 51424.48575514197, 51460.0, 46200.537994620296, 46420.535794642296, 46574.76712616415, 46685.533144668116, 46999.765001174776, 8215.260626543639, 8569.700060497853, 8570.871436928575, 8579.914200857911, 8731.607077681392, 29831.254218644706, 30172.849135754182, 30543.54184687187, 30651.54022689617, 31173.0, 38773.61226387813, 39205.803970981106, 39373.60626393699, 39760.0, 41106.79446602748, 12103.757924841279, 12329.705003919418, 12415.503379864704, 12446.564370246997, 12472.5010999559, 12576.937115314366, 12689.682757931125, 13149.868501315246, 13196.934015329862, 13220.933895330847, 12047.867824071804, 12253.632391028283, 12507.187032842836, 12671.049671274875, 12861.421236044587, 11974.0, 12260.816087758869, 12275.2021118627, 12279.2018518796, 12484.375781211085, 10377.636782712569, 11159.27464714791, 11278.605248816251, 11323.830142547704, 11834.230774999598, 9973.501324933579, 10006.799864002825, 10154.746131346776, 10472.424016679155, 10561.366318020637, 9896.356736812084, 10065.899341006496, 10081.243906707174, 10262.538185781508, 10309.07218350352], "value": 6516.415109124068, "unit": "score"}], "name": "dromaeo_css", "value": 7063.444505125668, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 113.0, 115.0, 110.0, 125.0, 112.0, 123.0, 114.0, 112.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 153.0, 187.0, 126.0, 154.0, 149.0, 136.0, 186.0, 132.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 166.0, 163.0, 165.0, 173.0, 165.0, 165.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 172.0, 76.0, 81.0, 73.0, 81.0, 175.0, 77.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 157.0, 91.0, 93.0, 92.0, 149.0, 94.0, 93.0, 144.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 120.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 103.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 62.0, 60.0, 60.0, 59.0, 59.0, 80.0, 57.0, 56.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 77.0, 77.0, 77.0, 79.0, 78.0, 79.0, 79.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 127.0, 127.0, 130.0, 139.0, 133.0, 122.0, 172.0, 139.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 168.0, 171.0, 171.0, 180.0, 167.0, 170.0, 171.0, 169.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 77.0, 72.0, 71.0, 69.0, 71.0, 68.0, 72.0, 71.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1577.4999999999998, "alertThreshold": 2.0}]} 02:29:04 INFO - Return code: 0 02:29:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:29:04 ERROR - # TBPL SUCCESS # 02:29:04 INFO - Running post-action listener: _resource_record_post_action 02:29:04 INFO - Running post-run listener: _resource_record_post_run 02:29:05 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536846336; Read time: 8; Write time: 463588 02:29:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244359168; Read time: 0; Write time: 289528 02:29:05 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291823616; Read time: 8; Write time: 174060 02:29:05 INFO - Running post-run listener: _upload_blobber_files 02:29:05 INFO - Blob upload gear active. 02:29:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:29:05 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 02:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:29:05 INFO - (blobuploader) - INFO - Open directory for files ... 02:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:29:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:06 INFO - (blobuploader) - INFO - Done attempting. 02:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:29:07 INFO - (blobuploader) - INFO - Done attempting. 02:29:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:29:07 INFO - Return code: 0 02:29:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:29:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:29:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/067d608272d0b1f6b6382e89af450d6b5d07183c2ea6d44143d3c7ed152edbef9fc371bc100a8651d68471a24705432dbbd6b4ee91f64afeb32852d701185da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca559c09536712d2e9a544ea2d35b9c9108618dcdb9344633fc24db988076aa8156782905962358cea3028b3f964f7cb65cece6b23517d5c1059df8e373cb0e8"} 02:29:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:29:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:29:07 INFO - Contents: 02:29:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/067d608272d0b1f6b6382e89af450d6b5d07183c2ea6d44143d3c7ed152edbef9fc371bc100a8651d68471a24705432dbbd6b4ee91f64afeb32852d701185da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca559c09536712d2e9a544ea2d35b9c9108618dcdb9344633fc24db988076aa8156782905962358cea3028b3f964f7cb65cece6b23517d5c1059df8e373cb0e8"} 02:29:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:29:07 INFO - Copying logs to upload dir... 02:29:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:29:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.758850 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-18 02:29:06.007472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 02:29:06.010513) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/067d608272d0b1f6b6382e89af450d6b5d07183c2ea6d44143d3c7ed152edbef9fc371bc100a8651d68471a24705432dbbd6b4ee91f64afeb32852d701185da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca559c09536712d2e9a544ea2d35b9c9108618dcdb9344633fc24db988076aa8156782905962358cea3028b3f964f7cb65cece6b23517d5c1059df8e373cb0e8"} build_url:https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/Qk79lz2FRVOR4MkKCKNQcw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/067d608272d0b1f6b6382e89af450d6b5d07183c2ea6d44143d3c7ed152edbef9fc371bc100a8651d68471a24705432dbbd6b4ee91f64afeb32852d701185da0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca559c09536712d2e9a544ea2d35b9c9108618dcdb9344633fc24db988076aa8156782905962358cea3028b3f964f7cb65cece6b23517d5c1059df8e373cb0e8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 02:29:06.034875) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:29:06.035190) ========= 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=337fe3f4b1febe37b85fccc40000019e-1460970117.135648-1354770886 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 02:29:06.118297) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 02:29:06.118668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 02:29:06.118969) ========= ========= Total master_lag: 0.99 =========