builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1464436871.49 results: success (0) buildid: 20160528023013 builduid: 082deb2ce0644edcbf76091fa2c1cc6b revision: 2e2c3435f648e36080c49c46416b710e0b52d55a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.489267) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.492919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.493201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.629108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.629391) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 05:01:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.3M=0s 2016-05-28 05:01:11 (42.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106278 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.763843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.764161) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015885 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:11.818124) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 05:01:11.818483) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e2c3435f648e36080c49c46416b710e0b52d55a --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 2e2c3435f648e36080c49c46416b710e0b52d55a --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=6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 05:01:12,027 truncating revision to first 12 chars 2016-05-28 05:01:12,027 Setting DEBUG logging. 2016-05-28 05:01:12,027 attempt 1/10 2016-05-28 05:01:12,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e2c3435f648?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 05:01:12,702 unpacking tar archive at: fx-team-2e2c3435f648/testing/mozharness/ program finished with exit code 0 elapsedTime=1.015112 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 05:01:12.852118) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.852514) ========= script_repo_revision: 2e2c3435f648e36080c49c46416b710e0b52d55a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.856372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.856786) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 05:01:12.868795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-28 05:01:12.869198) ========= /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=6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:13 INFO - MultiFileLogger online at 20160528 05:01:13 in /builds/slave/test 05:01:13 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 05:01:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:13 INFO - {'append_to_log': False, 05:01:13 INFO - 'base_work_dir': '/builds/slave/test', 05:01:13 INFO - 'blob_upload_branch': 'Fx-Team', 05:01:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:13 INFO - 'branch': 'Fx-Team', 05:01:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:13 INFO - 'config_files': ('talos/linux_config.py',), 05:01:13 INFO - 'default_actions': ('clobber', 05:01:13 INFO - 'read-buildbot-config', 05:01:13 INFO - 'download-and-extract', 05:01:13 INFO - 'populate-webroot', 05:01:13 INFO - 'create-virtualenv', 05:01:13 INFO - 'install', 05:01:13 INFO - 'run-tests'), 05:01:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:13 INFO - 'download_minidump_stackwalk': True, 05:01:13 INFO - 'download_symbols': 'ondemand', 05:01:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:13 INFO - 'installer_path': 'installer.exe', 05:01:13 INFO - 'log_level': 'info', 05:01:13 INFO - 'log_name': 'talos', 05:01:13 INFO - 'log_to_console': True, 05:01:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:13 INFO - 'opt_config_files': (), 05:01:13 INFO - 'pip_index': False, 05:01:13 INFO - 'sps_profile': False, 05:01:13 INFO - 'sps_profile_interval': 0, 05:01:13 INFO - 'suite': 'dromaeojs-e10s', 05:01:13 INFO - 'system_bits': '32', 05:01:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:13 INFO - 'title': 'talos-linux64-ix-023', 05:01:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:13 INFO - 'use_talos_json': True, 05:01:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:13 INFO - 'work_dir': 'build'} 05:01:13 INFO - ##### 05:01:13 INFO - ##### Running clobber step. 05:01:13 INFO - ##### 05:01:13 INFO - Running pre-action listener: _resource_record_pre_action 05:01:13 INFO - Running main action method: clobber 05:01:13 INFO - rmtree: /builds/slave/test/build 05:01:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:14 INFO - Running post-action listener: _resource_record_post_action 05:01:14 INFO - ##### 05:01:14 INFO - ##### Finished clobber step (success) 05:01:14 INFO - ##### 05:01:14 INFO - ##### 05:01:14 INFO - ##### Running read-buildbot-config step. 05:01:14 INFO - ##### 05:01:14 INFO - Running pre-action listener: _resource_record_pre_action 05:01:14 INFO - Running main action method: read_buildbot_config 05:01:14 INFO - Using buildbot properties: 05:01:14 INFO - { 05:01:14 INFO - "project": "", 05:01:14 INFO - "product": "firefox", 05:01:14 INFO - "script_repo_revision": "production", 05:01:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:01:14 INFO - "repository": "", 05:01:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:01:14 INFO - "buildid": "20160528023013", 05:01:14 INFO - "pgo_build": "True", 05:01:14 INFO - "basedir": "/builds/slave/test", 05:01:14 INFO - "buildnumber": 787, 05:01:14 INFO - "slavename": "talos-linux64-ix-023", 05:01:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:01:14 INFO - "platform": "ubuntu64_hw", 05:01:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:01:14 INFO - "branch": "fx-team", 05:01:14 INFO - "repo_path": "integration/fx-team", 05:01:14 INFO - "revision": "2e2c3435f648e36080c49c46416b710e0b52d55a", 05:01:14 INFO - "stage_platform": "linux64-pgo", 05:01:14 INFO - "builduid": "082deb2ce0644edcbf76091fa2c1cc6b", 05:01:14 INFO - "slavebuilddir": "test" 05:01:14 INFO - } 05:01:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:01:14 INFO - Running post-action listener: _resource_record_post_action 05:01:14 INFO - ##### 05:01:14 INFO - ##### Finished read-buildbot-config step (success) 05:01:14 INFO - ##### 05:01:14 INFO - ##### 05:01:14 INFO - ##### Running download-and-extract step. 05:01:14 INFO - ##### 05:01:14 INFO - Running pre-action listener: _resource_record_pre_action 05:01:14 INFO - Running main action method: download_and_extract 05:01:14 INFO - mkdir: /builds/slave/test/build/tests 05:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:14 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:01:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:01:22 INFO - Downloaded 1361 bytes. 05:01:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:01:22 INFO - Using the following test package requirements: 05:01:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:01:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:01:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'jsshell-linux-x86_64.zip'], 05:01:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:01:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:01:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:01:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:01:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:01:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:01:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:01:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:22 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:01:24 INFO - Downloaded 24410672 bytes. 05:01:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:01:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:01:25 INFO - Return code: 0 05:01:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:25 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:01:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:01:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:01:34 INFO - Downloaded 24410672 bytes. 05:01:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:01:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:01:35 INFO - Return code: 0 05:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:35 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:01:36 INFO - Downloaded 10834034 bytes. 05:01:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:01:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:01:36 INFO - Return code: 0 05:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:36 INFO - https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:01:38 INFO - Downloaded 58757754 bytes. 05:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:38 INFO - mkdir: /builds/slave/test/properties 05:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:01:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:01:38 INFO - Contents: 05:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:01:39 INFO - Running post-action listener: _resource_record_post_action 05:01:39 INFO - Running post-action listener: set_extra_try_arguments 05:01:39 INFO - ##### 05:01:39 INFO - ##### Finished download-and-extract step (success) 05:01:39 INFO - ##### 05:01:39 INFO - ##### 05:01:39 INFO - ##### Running populate-webroot step. 05:01:39 INFO - ##### 05:01:39 INFO - Running pre-action listener: _resource_record_pre_action 05:01:39 INFO - Running main action method: populate_webroot 05:01:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:39 INFO - '--tppagecycles', 05:01:39 INFO - '7'], 05:01:39 INFO - 'tests': ['tsvgm']}}, 05:01:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:01:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:01:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:01:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:39 INFO - 'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:39 INFO - 'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['damp', 'tps']}, 05:01:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:39 INFO - 'tests': ['damp', 'tps']}, 05:01:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['dromaeo_dom']}, 05:01:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['a11yr', 05:01:39 INFO - 'ts_paint', 05:01:39 INFO - 'tpaint', 05:01:39 INFO - 'sessionrestore', 05:01:39 INFO - 'sessionrestore_no_auto_restore', 05:01:39 INFO - 'tabpaint']}, 05:01:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:01:39 INFO - 'ts_paint', 05:01:39 INFO - 'tpaint', 05:01:39 INFO - 'sessionrestore', 05:01:39 INFO - 'sessionrestore_no_auto_restore', 05:01:39 INFO - 'tabpaint']}, 05:01:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:01:39 INFO - 'ts_paint', 05:01:39 INFO - 'tpaint', 05:01:39 INFO - 'sessionrestore', 05:01:39 INFO - 'sessionrestore_no_auto_restore', 05:01:39 INFO - 'tabpaint']}, 05:01:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:01:39 INFO - 'ts_paint', 05:01:39 INFO - 'tpaint', 05:01:39 INFO - 'sessionrestore', 05:01:39 INFO - 'sessionrestore_no_auto_restore', 05:01:39 INFO - 'tabpaint']}, 05:01:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['a11yr', 05:01:39 INFO - 'ts_paint', 05:01:39 INFO - 'tpaint', 05:01:39 INFO - 'sessionrestore', 05:01:39 INFO - 'sessionrestore_no_auto_restore', 05:01:39 INFO - 'tabpaint']}, 05:01:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['a11yr', 05:01:39 INFO - 'ts_paint', 05:01:39 INFO - 'tpaint', 05:01:39 INFO - 'sessionrestore', 05:01:39 INFO - 'sessionrestore_no_auto_restore', 05:01:39 INFO - 'tabpaint']}, 05:01:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['tsvgx', 05:01:39 INFO - 'tsvgr_opacity', 05:01:39 INFO - 'tart', 05:01:39 INFO - 'tscrollx', 05:01:39 INFO - 'cart']}, 05:01:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:01:39 INFO - 'tsvgr_opacity', 05:01:39 INFO - 'tart', 05:01:39 INFO - 'tscrollx', 05:01:39 INFO - 'cart']}, 05:01:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:39 INFO - 'talos_options': ['--disable-e10s'], 05:01:39 INFO - 'tests': ['tp5o']}, 05:01:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:39 INFO - 'tests': ['tp5o']}, 05:01:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:39 INFO - 'talos_options': ['--disable-e10s', 05:01:39 INFO - '--xperf_path', 05:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:39 INFO - 'tests': ['tp5n']}, 05:01:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:01:39 INFO - 'talos_options': ['--xperf_path', 05:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:39 INFO - 'tests': ['tp5n']}}, 05:01:39 INFO - 'talos.zip': {'path': '', 05:01:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:39 INFO - Running post-action listener: _resource_record_post_action 05:01:39 INFO - ##### 05:01:39 INFO - ##### Finished populate-webroot step (success) 05:01:39 INFO - ##### 05:01:39 INFO - ##### 05:01:39 INFO - ##### Running create-virtualenv step. 05:01:39 INFO - ##### 05:01:39 INFO - Running pre-action listener: _resource_record_pre_action 05:01:39 INFO - Running main action method: create_virtualenv 05:01:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:01:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:01:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:01:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:39 INFO - Using real prefix '/usr' 05:01:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:41 INFO - Installing pip.................done. 05:01:41 INFO - Return code: 0 05:01:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:01:41 INFO - Using env: {'DISPLAY': ':0', 05:01:41 INFO - 'HOME': '/home/cltbld', 05:01:41 INFO - 'LANG': 'en_US.UTF-8', 05:01:41 INFO - 'LANGUAGE': 'en_US:en', 05:01:41 INFO - 'LOGNAME': 'cltbld', 05:01:41 INFO - 'MAIL': '/var/mail/cltbld', 05:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:41 INFO - 'MOZ_NO_REMOTE': '1', 05:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:41 INFO - 'NO_EM_RESTART': '1', 05:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:41 INFO - 'PWD': '/builds/slave/test', 05:01:41 INFO - 'SHELL': '/bin/bash', 05:01:41 INFO - 'SHLVL': '1', 05:01:41 INFO - 'TERM': 'linux', 05:01:41 INFO - 'TMOUT': '86400', 05:01:41 INFO - 'USER': 'cltbld', 05:01:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:41 INFO - '_': '/tools/buildbot/bin/python'} 05:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:01:41 INFO - Cleaning up... 05:01:41 INFO - Return code: 0 05:01:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:01:41 INFO - Using env: {'DISPLAY': ':0', 05:01:41 INFO - 'HOME': '/home/cltbld', 05:01:41 INFO - 'LANG': 'en_US.UTF-8', 05:01:41 INFO - 'LANGUAGE': 'en_US:en', 05:01:41 INFO - 'LOGNAME': 'cltbld', 05:01:41 INFO - 'MAIL': '/var/mail/cltbld', 05:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:41 INFO - 'MOZ_NO_REMOTE': '1', 05:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:41 INFO - 'NO_EM_RESTART': '1', 05:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:41 INFO - 'PWD': '/builds/slave/test', 05:01:41 INFO - 'SHELL': '/bin/bash', 05:01:41 INFO - 'SHLVL': '1', 05:01:41 INFO - 'TERM': 'linux', 05:01:41 INFO - 'TMOUT': '86400', 05:01:41 INFO - 'USER': 'cltbld', 05:01:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:41 INFO - '_': '/tools/buildbot/bin/python'} 05:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:42 INFO - Downloading/unpacking psutil>=3.1.1 05:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:44 INFO - Installing collected packages: psutil 05:01:44 INFO - Running setup.py install for psutil 05:01:44 INFO - building 'psutil._psutil_linux' extension 05:01:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:01:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:01:44 INFO - building 'psutil._psutil_posix' extension 05:01:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:01:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:01:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:01:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:01:44 INFO - Successfully installed psutil 05:01:44 INFO - Cleaning up... 05:01:44 INFO - Return code: 0 05:01:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:44 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:44 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.3'] in /builds/slave/test/build 05:01:44 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.3 05:01:44 INFO - Using env: {'DISPLAY': ':0', 05:01:44 INFO - 'HOME': '/home/cltbld', 05:01:44 INFO - 'LANG': 'en_US.UTF-8', 05:01:44 INFO - 'LANGUAGE': 'en_US:en', 05:01:44 INFO - 'LOGNAME': 'cltbld', 05:01:44 INFO - 'MAIL': '/var/mail/cltbld', 05:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:44 INFO - 'MOZ_NO_REMOTE': '1', 05:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:44 INFO - 'NO_EM_RESTART': '1', 05:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:44 INFO - 'PWD': '/builds/slave/test', 05:01:44 INFO - 'SHELL': '/bin/bash', 05:01:44 INFO - 'SHLVL': '1', 05:01:44 INFO - 'TERM': 'linux', 05:01:44 INFO - 'TMOUT': '86400', 05:01:44 INFO - 'USER': 'cltbld', 05:01:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:44 INFO - '_': '/tools/buildbot/bin/python'} 05:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:01:46 INFO - Installing collected packages: mozsystemmonitor 05:01:46 INFO - Running setup.py install for mozsystemmonitor 05:01:46 INFO - Successfully installed mozsystemmonitor 05:01:46 INFO - Cleaning up... 05:01:46 INFO - Return code: 0 05:01:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:46 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 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:01:46 INFO - Using env: {'DISPLAY': ':0', 05:01:46 INFO - 'HOME': '/home/cltbld', 05:01:46 INFO - 'LANG': 'en_US.UTF-8', 05:01:46 INFO - 'LANGUAGE': 'en_US:en', 05:01:46 INFO - 'LOGNAME': 'cltbld', 05:01:46 INFO - 'MAIL': '/var/mail/cltbld', 05:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:46 INFO - 'MOZ_NO_REMOTE': '1', 05:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:46 INFO - 'NO_EM_RESTART': '1', 05:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:46 INFO - 'PWD': '/builds/slave/test', 05:01:46 INFO - 'SHELL': '/bin/bash', 05:01:46 INFO - 'SHLVL': '1', 05:01:46 INFO - 'TERM': 'linux', 05:01:46 INFO - 'TMOUT': '86400', 05:01:46 INFO - 'USER': 'cltbld', 05:01:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:46 INFO - '_': '/tools/buildbot/bin/python'} 05:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:48 INFO - Downloading blobuploader-1.2.4.tar.gz 05:01:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:01:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:01:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:49 INFO - Downloading docopt-0.6.1.tar.gz 05:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:01:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:01:49 INFO - Running setup.py install for blobuploader 05:01:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:01:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:01:49 INFO - Running setup.py install for requests 05:01:50 INFO - Running setup.py install for docopt 05:01:50 INFO - Successfully installed blobuploader requests docopt 05:01:50 INFO - Cleaning up... 05:01:50 INFO - Return code: 0 05:01:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:50 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 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:50 INFO - Using env: {'DISPLAY': ':0', 05:01:50 INFO - 'HOME': '/home/cltbld', 05:01:50 INFO - 'LANG': 'en_US.UTF-8', 05:01:50 INFO - 'LANGUAGE': 'en_US:en', 05:01:50 INFO - 'LOGNAME': 'cltbld', 05:01:50 INFO - 'MAIL': '/var/mail/cltbld', 05:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:50 INFO - 'MOZ_NO_REMOTE': '1', 05:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:50 INFO - 'NO_EM_RESTART': '1', 05:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:50 INFO - 'PWD': '/builds/slave/test', 05:01:50 INFO - 'SHELL': '/bin/bash', 05:01:50 INFO - 'SHLVL': '1', 05:01:50 INFO - 'TERM': 'linux', 05:01:50 INFO - 'TMOUT': '86400', 05:01:50 INFO - 'USER': 'cltbld', 05:01:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:50 INFO - '_': '/tools/buildbot/bin/python'} 05:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:50 INFO - Running setup.py (path:/tmp/pip-wbIBby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:50 INFO - Running setup.py (path:/tmp/pip-wgaU5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:50 INFO - Running setup.py (path:/tmp/pip-mA5nqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:50 INFO - Running setup.py (path:/tmp/pip-FIUFXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:50 INFO - Running setup.py (path:/tmp/pip-pXGFGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:50 INFO - Running setup.py (path:/tmp/pip-GlRNEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:50 INFO - Running setup.py (path:/tmp/pip-PHpT7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:51 INFO - Running setup.py (path:/tmp/pip-lqPQyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:51 INFO - Running setup.py (path:/tmp/pip-BOCkUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:51 INFO - Running setup.py (path:/tmp/pip-qWwgJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:51 INFO - Running setup.py (path:/tmp/pip-f2ZCJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:51 INFO - Running setup.py (path:/tmp/pip-zZ5lsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:51 INFO - Running setup.py (path:/tmp/pip-ug1h4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:51 INFO - Running setup.py (path:/tmp/pip-q1Yavh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:51 INFO - Running setup.py (path:/tmp/pip-t7zQFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:51 INFO - Running setup.py (path:/tmp/pip-HUcZQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:51 INFO - Running setup.py (path:/tmp/pip-A5RNKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:51 INFO - Running setup.py install for manifestparser 05:01:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:01:51 INFO - Running setup.py install for mozcrash 05:01:52 INFO - Running setup.py install for mozdebug 05:01:52 INFO - Running setup.py install for mozdevice 05:01:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Running setup.py install for mozfile 05:01:52 INFO - Running setup.py install for mozhttpd 05:01:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Running setup.py install for mozinfo 05:01:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Running setup.py install for mozInstall 05:01:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Running setup.py install for mozleak 05:01:52 INFO - Running setup.py install for mozlog 05:01:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Running setup.py install for moznetwork 05:01:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:01:52 INFO - Running setup.py install for mozprocess 05:01:53 INFO - Running setup.py install for mozprofile 05:01:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Running setup.py install for mozrunner 05:01:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Running setup.py install for mozscreenshot 05:01:53 INFO - Running setup.py install for moztest 05:01:53 INFO - Running setup.py install for mozversion 05:01:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:01:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:53 INFO - Cleaning up... 05:01:53 INFO - Return code: 0 05:01:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:53 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 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:53 INFO - Using env: {'DISPLAY': ':0', 05:01:53 INFO - 'HOME': '/home/cltbld', 05:01:53 INFO - 'LANG': 'en_US.UTF-8', 05:01:53 INFO - 'LANGUAGE': 'en_US:en', 05:01:53 INFO - 'LOGNAME': 'cltbld', 05:01:53 INFO - 'MAIL': '/var/mail/cltbld', 05:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:53 INFO - 'MOZ_NO_REMOTE': '1', 05:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:53 INFO - 'NO_EM_RESTART': '1', 05:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:53 INFO - 'PWD': '/builds/slave/test', 05:01:53 INFO - 'SHELL': '/bin/bash', 05:01:53 INFO - 'SHLVL': '1', 05:01:53 INFO - 'TERM': 'linux', 05:01:53 INFO - 'TMOUT': '86400', 05:01:53 INFO - 'USER': 'cltbld', 05:01:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:53 INFO - '_': '/tools/buildbot/bin/python'} 05:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:53 INFO - Running setup.py (path:/tmp/pip-spYASt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:53 INFO - Running setup.py (path:/tmp/pip-aWsKr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:53 INFO - Running setup.py (path:/tmp/pip-adPW38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:54 INFO - Running setup.py (path:/tmp/pip-KpVdlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:54 INFO - Running setup.py (path:/tmp/pip-O5RkLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:54 INFO - Running setup.py (path:/tmp/pip-rtpG6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:54 INFO - Running setup.py (path:/tmp/pip-_VpI5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:54 INFO - Running setup.py (path:/tmp/pip-lkLJjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:54 INFO - Running setup.py (path:/tmp/pip-NyyKk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:54 INFO - Running setup.py (path:/tmp/pip-XdWjBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:54 INFO - Running setup.py (path:/tmp/pip-2W7Fy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:54 INFO - Running setup.py (path:/tmp/pip-95S0dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:54 INFO - Running setup.py (path:/tmp/pip-BhYn0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:54 INFO - Running setup.py (path:/tmp/pip-YKgAsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:54 INFO - Running setup.py (path:/tmp/pip-ljbK0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:54 INFO - Running setup.py (path:/tmp/pip-PNhYpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:55 INFO - Running setup.py (path:/tmp/pip-30qj8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:56 INFO - Downloading blessings-1.6.tar.gz 05:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:57 INFO - Installing collected packages: blessings 05:01:57 INFO - Running setup.py install for blessings 05:01:57 INFO - Successfully installed blessings 05:01:57 INFO - Cleaning up... 05:01:57 INFO - Return code: 0 05:01:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:01:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:57 INFO - Reading from file tmpfile_stdout 05:01:57 INFO - Current package versions: 05:01:57 INFO - argparse == 1.2.1 05:01:57 INFO - blessings == 1.6 05:01:57 INFO - blobuploader == 1.2.4 05:01:57 INFO - docopt == 0.6.1 05:01:57 INFO - manifestparser == 1.1 05:01:57 INFO - mozInstall == 1.12 05:01:57 INFO - mozcrash == 0.17 05:01:57 INFO - mozdebug == 0.1 05:01:57 INFO - mozdevice == 0.48 05:01:57 INFO - mozfile == 1.2 05:01:57 INFO - mozhttpd == 0.7 05:01:57 INFO - mozinfo == 0.9 05:01:57 INFO - mozleak == 0.1 05:01:57 INFO - mozlog == 3.2 05:01:57 INFO - moznetwork == 0.27 05:01:57 INFO - mozprocess == 0.22 05:01:57 INFO - mozprofile == 0.28 05:01:57 INFO - mozrunner == 6.11 05:01:57 INFO - mozscreenshot == 0.1 05:01:57 INFO - mozsystemmonitor == 0.3 05:01:57 INFO - moztest == 0.7 05:01:57 INFO - mozversion == 1.4 05:01:57 INFO - psutil == 3.1.1 05:01:57 INFO - requests == 1.2.3 05:01:57 INFO - wsgiref == 0.1.2 05:01:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:57 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 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:01:57 INFO - Using env: {'DISPLAY': ':0', 05:01:57 INFO - 'HOME': '/home/cltbld', 05:01:57 INFO - 'LANG': 'en_US.UTF-8', 05:01:57 INFO - 'LANGUAGE': 'en_US:en', 05:01:57 INFO - 'LOGNAME': 'cltbld', 05:01:57 INFO - 'MAIL': '/var/mail/cltbld', 05:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:57 INFO - 'MOZ_NO_REMOTE': '1', 05:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:57 INFO - 'NO_EM_RESTART': '1', 05:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:57 INFO - 'PWD': '/builds/slave/test', 05:01:57 INFO - 'SHELL': '/bin/bash', 05:01:57 INFO - 'SHLVL': '1', 05:01:57 INFO - 'TERM': 'linux', 05:01:57 INFO - 'TMOUT': '86400', 05:01:57 INFO - 'USER': 'cltbld', 05:01:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:57 INFO - '_': '/tools/buildbot/bin/python'} 05:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:01:57 INFO - Cleaning up... 05:01:57 INFO - Return code: 0 05:01:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:57 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 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:01:57 INFO - Using env: {'DISPLAY': ':0', 05:01:57 INFO - 'HOME': '/home/cltbld', 05:01:57 INFO - 'LANG': 'en_US.UTF-8', 05:01:57 INFO - 'LANGUAGE': 'en_US:en', 05:01:57 INFO - 'LOGNAME': 'cltbld', 05:01:57 INFO - 'MAIL': '/var/mail/cltbld', 05:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:57 INFO - 'MOZ_NO_REMOTE': '1', 05:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:57 INFO - 'NO_EM_RESTART': '1', 05:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:57 INFO - 'PWD': '/builds/slave/test', 05:01:57 INFO - 'SHELL': '/bin/bash', 05:01:57 INFO - 'SHLVL': '1', 05:01:57 INFO - 'TERM': 'linux', 05:01:57 INFO - 'TMOUT': '86400', 05:01:57 INFO - 'USER': 'cltbld', 05:01:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:57 INFO - '_': '/tools/buildbot/bin/python'} 05:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:57 INFO - Downloading/unpacking jsonschema 05:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:01:59 INFO - Downloading/unpacking functools32 (from jsonschema) 05:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:59 INFO - Downloading functools32-3.2.3-2.tar.gz 05:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:01:59 INFO - warning: no files found matching '*.txt' 05:01:59 INFO - no previously-included directories found matching 'build' 05:01:59 INFO - no previously-included directories found matching 'dist' 05:01:59 INFO - no previously-included directories found matching '.git*' 05:02:00 INFO - Installing collected packages: jsonschema, functools32 05:02:00 INFO - Running setup.py install for functools32 05:02:00 INFO - warning: no files found matching '*.txt' 05:02:00 INFO - no previously-included directories found matching 'build' 05:02:00 INFO - no previously-included directories found matching 'dist' 05:02:00 INFO - no previously-included directories found matching '.git*' 05:02:00 INFO - Successfully installed jsonschema functools32 05:02:00 INFO - Cleaning up... 05:02:00 INFO - Return code: 0 05:02:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b49f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, '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': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:02:00 INFO - Using env: {'DISPLAY': ':0', 05:02:00 INFO - 'HOME': '/home/cltbld', 05:02:00 INFO - 'LANG': 'en_US.UTF-8', 05:02:00 INFO - 'LANGUAGE': 'en_US:en', 05:02:00 INFO - 'LOGNAME': 'cltbld', 05:02:00 INFO - 'MAIL': '/var/mail/cltbld', 05:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:00 INFO - 'MOZ_NO_REMOTE': '1', 05:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:00 INFO - 'NO_EM_RESTART': '1', 05:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:00 INFO - 'PWD': '/builds/slave/test', 05:02:00 INFO - 'SHELL': '/bin/bash', 05:02:00 INFO - 'SHLVL': '1', 05:02:00 INFO - 'TERM': 'linux', 05:02:00 INFO - 'TMOUT': '86400', 05:02:00 INFO - 'USER': 'cltbld', 05:02:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:00 INFO - '_': '/tools/buildbot/bin/python'} 05:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:00 INFO - Downloading/unpacking flake8 05:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:02:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:02:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:03 INFO - no previously-included directories found matching 'docs/_build' 05:02:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:02:03 INFO - Running setup.py install for pep8 05:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:02:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:02:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:02:03 INFO - no previously-included directories found matching 'docs/_build' 05:02:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:02:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:02:03 INFO - Cleaning up... 05:02:03 INFO - Return code: 0 05:02:03 INFO - Running post-action listener: _resource_record_post_action 05:02:03 INFO - Running post-action listener: _start_resource_monitoring 05:02:03 INFO - Starting resource monitoring. 05:02:03 INFO - ##### 05:02:03 INFO - ##### Finished create-virtualenv step (success) 05:02:03 INFO - ##### 05:02:03 INFO - ##### 05:02:03 INFO - ##### Running install step. 05:02:03 INFO - ##### 05:02:03 INFO - Running pre-action listener: _resource_record_pre_action 05:02:03 INFO - Running main action method: install 05:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:03 INFO - Reading from file tmpfile_stdout 05:02:03 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:03 INFO - Reading from file tmpfile_stdout 05:02:03 INFO - Output received: 05:02:03 INFO - Usage: mozinstall [options] installer 05:02:03 INFO - Options: 05:02:03 INFO - -h, --help show this help message and exit 05:02:03 INFO - -d DEST, --destination=DEST 05:02:03 INFO - Directory to install application into. [default: 05:02:03 INFO - "/builds/slave/test"] 05:02:03 INFO - --app=APP Application being installed. [default: firefox] 05:02:03 INFO - mkdir: /builds/slave/test/build/application 05:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:02:20 INFO - Reading from file tmpfile_stdout 05:02:20 INFO - Output received: 05:02:20 INFO - /builds/slave/test/build/application/firefox/firefox 05:02:20 INFO - Running post-action listener: _resource_record_post_action 05:02:20 INFO - ##### 05:02:20 INFO - ##### Finished install step (success) 05:02:20 INFO - ##### 05:02:20 INFO - ##### 05:02:20 INFO - ##### Running run-tests step. 05:02:20 INFO - ##### 05:02:20 INFO - Running pre-action listener: _resource_record_pre_action 05:02:20 INFO - Running main action method: run_tests 05:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:20 INFO - Python 2.7.3 05:02:20 INFO - Return code: 0 05:02:20 INFO - grabbing minidump binary from tooltool 05:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:02:20 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d9c0>, '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 0x231e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:02:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:02:20 INFO - Calling ['/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'] with output_timeout 600 05:02:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:20 INFO - Return code: 0 05:02:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:02:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:02:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:02:21 INFO - Return code: 0 05:02:21 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/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:02:21 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/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:02:21 INFO - Using env: {'DISPLAY': ':0', 05:02:21 INFO - 'HOME': '/home/cltbld', 05:02:21 INFO - 'LANG': 'en_US.UTF-8', 05:02:21 INFO - 'LANGUAGE': 'en_US:en', 05:02:21 INFO - 'LOGNAME': 'cltbld', 05:02:21 INFO - 'MAIL': '/var/mail/cltbld', 05:02:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:21 INFO - 'MOZ_NO_REMOTE': '1', 05:02:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:21 INFO - 'NO_EM_RESTART': '1', 05:02:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:21 INFO - 'PWD': '/builds/slave/test', 05:02:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:21 INFO - 'SHELL': '/bin/bash', 05:02:21 INFO - 'SHLVL': '1', 05:02:21 INFO - 'TERM': 'linux', 05:02:21 INFO - 'TMOUT': '86400', 05:02:21 INFO - 'USER': 'cltbld', 05:02:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996', 05:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:21 INFO - '_': '/tools/buildbot/bin/python'} 05:02:21 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/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:02:21 INFO - mozversion application_buildid: 20160528023013 05:02:21 INFO - mozversion application_changeset: 2e2c3435f648e36080c49c46416b710e0b52d55a 05:02:21 INFO - mozversion application_display_name: Nightly 05:02:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:21 INFO - mozversion application_name: Firefox 05:02:21 INFO - mozversion application_remotingname: firefox 05:02:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:02:21 INFO - mozversion application_vendor: Mozilla 05:02:21 INFO - mozversion application_version: 49.0a1 05:02:21 INFO - mozversion platform_buildid: 20160528023013 05:02:21 INFO - mozversion platform_changeset: 2e2c3435f648e36080c49c46416b710e0b52d55a 05:02:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:02:21 INFO - mozversion platform_version: 49.0a1 05:02:21 INFO - using testdate: 1464436941 05:02:21 INFO - actual date: 1464436941 05:02:21 INFO - starting webserver on 'localhost:42022' 05:02:21 INFO - SUITE-START | Running 2 tests 05:02:21 INFO - TEST-START | dromaeo_css 05:02:21 INFO - operating with platform_type : linux_ 05:02:21 INFO - Initialising browser for dromaeo_css test... 05:02:21 INFO - TEST-INFO | started process 11030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkqEP5S/profile http://localhost:42022/getInfo.html) 05:02:25 INFO - PROCESS | 11030 | 05:02:25 INFO - PROCESS | 11030 | (process:11100): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:02:26 INFO - PROCESS | 11030 | __metrics Screen width/height:1600/1200 05:02:26 INFO - PROCESS | 11030 | colorDepth:24 05:02:26 INFO - PROCESS | 11030 | Browser inner width/height: 1024/697 05:02:26 INFO - PROCESS | 11030 | __metrics 05:02:26 ERROR - PROCESS | 11030 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:02:27 INFO - TEST-INFO | 11030: exit 0 05:02:27 INFO - Browser initialized. 05:02:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:27 INFO - TEST-INFO | started process 11151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkqEP5S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:29 INFO - PROCESS | 11151 | 05:02:29 INFO - PROCESS | 11151 | (process:11214): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:02:39 INFO - PROCESS | 11151 | RSS: Main: 166535168 05:02:39 INFO - PROCESS | 11151 | 05:03:28 INFO - PROCESS | 11151 | 1464437008913 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:05:36 INFO - PROCESS | 11151 | Cycle 1(1): loaded http://localhost:42022/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42022/tests/dromaeo/cssquery-ext.html) 05:05:37 INFO - PROCESS | 11151 | RSS: Main: 170479616 05:05:37 INFO - PROCESS | 11151 | 05:08:39 INFO - PROCESS | 11151 | Cycle 1(1): loaded http://localhost:42022/tests/dromaeo/cssquery-ext.html (next: http://localhost:42022/tests/dromaeo/cssquery-jquery.html) 05:08:39 INFO - PROCESS | 11151 | RSS: Main: 169164800 05:08:39 INFO - PROCESS | 11151 | 05:11:41 INFO - PROCESS | 11151 | Cycle 1(1): loaded http://localhost:42022/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42022/tests/dromaeo/cssquery-mootools.html) 05:11:42 INFO - PROCESS | 11151 | RSS: Main: 170356736 05:11:42 INFO - PROCESS | 11151 | 05:14:44 INFO - PROCESS | 11151 | Cycle 1(1): loaded http://localhost:42022/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42022/tests/dromaeo/cssquery-prototype.html) 05:14:44 INFO - PROCESS | 11151 | RSS: Main: 168148992 05:14:44 INFO - PROCESS | 11151 | 05:17:47 INFO - PROCESS | 11151 | Cycle 1(1): loaded http://localhost:42022/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42022/tests/dromaeo/cssquery-yui.html) 05:17:47 INFO - PROCESS | 11151 | RSS: Main: 170020864 05:17:47 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | Cycle 1(1): loaded http://localhost:42022/tests/dromaeo/cssquery-yui.html (next: http://localhost:42022/tests/dromaeo/cssquery-dojo.html) 05:20:50 INFO - PROCESS | 11151 | RSS: Main: 171499520 05:20:50 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | __start_tp_report 05:20:50 INFO - PROCESS | 11151 | _x_x_mozilla_page_load 05:20:50 INFO - PROCESS | 11151 | _x_x_mozilla_page_load_details 05:20:50 INFO - PROCESS | 11151 | |i|pagename|runs| 05:20:50 INFO - PROCESS | 11151 | |0;dojo.html;3119.4073126106036;3156.1793933577264;3162.114607909785;3167.2081979505124;3201.5998000249983;5418.322709661293;5464.344278686558;5502.944970550293;5542.7782888684405;5552.77788888445;5354.2771725817;5406.432324605909;5429.4570542945685;5473.616846820724;5565.777368905239;4900.11797876383;4947.950520494803;5048.141815891289;5086.059079070384;5152.098382783017;720.9649760799558;4850.2724591311235;4935.506449355072;5003.274525193845;5056.216286475602;4912.852614421573;4946.431160416544;4978.950210497885;4979.626528010395;4981.402231732197;4993.1262029144755;5015.949840501621;5017.046761115376;5018.673786203885;5027.49725027498;4933.28467372229;4965.205567109245;4979.1784355581285;5000.524950129732;5006.374203224597;5352.652077614943;5353.625246232766;5382.811601593965;5407.783688652449;5435.728213589305;5635.3237611486475;5780.971095144498;5843.766249350021;5917.881642367129;5924.289085309747;5838.503727183194;5886.175935369051;5893.440123188333;5938.970305148447;5983.790567330166;5504.036793561111;5509.393966663663;5517.227588137664;5517.668939863621;5518.089515229983;5823.621464604787;5941.227640406806;5964.522838172936;6047.516198704093;6049.243844519435;5729.369769325371;5733.8566535836935;5736.799212027559;5745.052066409079;5750.769969201268;5906.940930590725;5912.645241285537;5913.852153696106;5916.201312822714;5924.081767325985;5854.912176317359;5884.705764711747;5889;5914.6746928918465;5954.732037058343;5909.497692696169;5924.851878702981;5936.168936348915;5946.226990491208;5960.910586341209;4402.471703395549;4502.57225563571;4505.594496495331;4508.481524624644;4550.97724511382;3902.785346805953;3934.075492259317;3968.3849003404516;4000.299947509174;4001.2597669431248;5556.861078473071;5571.860703482364;5637.915431268534;5648.293963254593;5681.715914204356;5791.82624521265;5931.614445061057;5960.403959604005;5965.850853728692;5967.582269241198;5599.552035837123;5639;5650.74571644277;5675.517581005661;5681.971590142023;5005.949940500548;5056.519630635084;5066.290719299301;5081.441041485434;5094.719790411563;5947.5539334550085;6091.604045737013;6205.565610407228;6209.9068513972325;6225.408586184305;5859.677717725481;6001.159837622824;6003.129546215861;6008.669523176267;6056.666883321372;6121.663308518075;6163.8150855474405;6200.875982480416;6211.09939058843;6218.253809542703;5586.357568879631;5768.711564421678;5798.391168927202;5876.6180198286975;5877.823665290048;5931.851703707269;5984.850378740566;5989.9700501498955;5995.760169593167;6003.159557661844;5722.484976352148;5733.741981610921;5761.8559536011935;5764.913526297025;5776.844631073718;5518.668879867221;5677.772889084556;5696.287964004499;5712.971665100322;5746.339170995389;5657.660540367427;5714.685692286964;5735.053716136791;5748;5760.567957403296;5832.825015249549;5835.978703726746;5840.415958404125;5854.619449735754;5872.941270587239;5510.008198524304;5573.832785016456;5574.191742197439;5612.85967850807;5658.377578466283 05:20:50 INFO - PROCESS | 11151 | |1;ext.html;587.6503480429143;620.2680836612798;634.7556190866518;645.9903101453477;672.2101530701431;39248.41127383088;40975.180496390094;44698;44835.551644483545;44862.55137448625;45796;46422.76788616052;46509.767451162785;46578.30132548015;46679.53320466794;8855.203031727144;8955.820883582357;9010.14403631654;9026.413283136608;9027.142421469982;8872.423292485968;8897;8938.955305223464;8958.37291389603;8990.640374385017;8946.642134314652;9027;9031.142041506046;9044.050374710627;9044.412113212653;8953.865692014626;9004.909950900505;9021;9021.819563608691;9022.052684468103;8847.20375166238;8928.553572321423;8981.640734370683;8991.775205619846;8999.685011024583;29663;42461;43276.350854737204;43323.78338108321;43346.78326608378;3266.3304022675534;3325.6508066653137;3593.730470214718;3619.873304434332;4248.362745588156;30380.088597341895;30561.69438305633;30750.692493075006;30760.077197684106;30932.690673093206;3939.1333906540517;3960;3967.3652215645648;3968.6626636735914;4202.600752928467;296793;296870.546941796;298201;298433;299999;35666.82166589202;35964.10089747777;36123.4581481278;36154.09614759652;36189.45715814265;36313;37077.25845483075;37260.44109338362;38168;38363.424548631796;15039;15098;15180.848191517944;15202.239888005777;15224.695506090038;13041.739165216643;13052.673683157996;13097.934510327388;13150.145240559525;13167;19765.802341976683;19799.505012374517;19914.50213744668;19924.800751992585;20153.294634687714;7088.432925365958;7296.452766042568;7397.743688175051;7426.814329641802;7433.739819106306;939.9013103624021;986.753311672082;1039.1219419590434;1155.9711007224887;1181.8699943006263;28981.142542958234;29098.7090129096;29156.27109322284;29638.703612963593;29678.40643187124;1094.3871431998107;1108.3737688206138;1154.186298659443;1193.26614132308;1237.4161073825517;16815.495535133967;17391.391301304393;17423;17487.213075411637;17736.113194340232;521826;529450;529909;531960;534655;59835.40164598385;60137.699311503166;60327;60449;60765.39234607686;1236.6970092327438;1319.2546211390725;1390.4090761426353;1396.2320723602181;1406.3882211238144;30889.227769305948;32354.676453235166;32746.34507309888;32809.343813124084;33075.83462082771;50971.235431467816;51314.23028654648;51404;51614.225786613984;51785;391109;392795;393586;393958;394693;28421.289467763472;28472.430551389272;28913.277168070967;28963.275918102216;29223;48567.757161215384;48692.75653621851;49143;49297.50702492929;49696.75151624363;42100.789496052326;42587;42621.57378426176;42964.35553466763;43445.348319774595;41940.16119677528;42165.367519486615;42279.509093360975;42329;42416.575834242496;32728.18179545435;40425;41252.38121428121;42163.578364215966;42806;35937.82031089828;36851;37087.81456092702;37877.81061094677;38012.80993595014;25780.742192577833;25819.741802581735;25938.48123037491;26107.869460652575;26221.781566531165 05:20:50 INFO - PROCESS | 11151 | |2;jquery.html;375.1296990980924;386.2583839029064;390.7655406755945;394.62313490616447;410.6960848971762;18037.564928734617;19628.116734746935;20199.19203231869;20573.691394629073;20589.485262868417;17198.226079826407;17373.391931282407;17607.29570817169;18519.72220416695;19286.32497862575;5525.917111243334;5604.41153678864;5695.515881150107;5747.3677895431465;5763.596548241625;5613.186088017235;5653.717314134297;5671.149327600851;5671.319441667006;5677.886442271152;5600.52395546377;5604.495595396414;5611.130274807411;5614.831555053355;5636.520895723868;5598.300212473441;5619.662820230778;5625.831225063254;5632.549396048306;5656.462636049569;4864.805407783684;4909.631777616693;5019.247112933089;5059.949400505985;5080.542751152377;22673.773262267496;22930.312090637308;22979;23124.53750924989;23160.88419557908;2401.615741481372;2435;2478.7397323281157;2530.9493810123695;2933.9413211735646;13892.23592702401;14152.29238538069;14245.715085698228;14315.713685726227;14902.403903843833;1917.4631103291101;1996;1998.6202621501868;2028.7058376535467;2064.8038436348525;75282;78748;79376.20623793804;80056.59971700162;80628.38743225162;10245.180385569136;10258.230632702427;10521.631742888962;10681;10781.568737250578;14647.780283295759;14651.633709157144;14665.413383464755;14672;14710.19093949843;7463.738769143054;7721;7754.418418618626;7809.180036096128;8033.317168040665;7417.33244008031;7523;7697.961510192413;7762.5730584818375;7819.452638315377;6440.194975628046;6445.323241059715;6693.765718199839;6694.899576506356;6698.531102822755;1867.9906600466911;1941.5437372217518;1944.6694062009492;1962.8037196280543;1968.5669152786363;904.2856143646577;923.8706581078654;933.8132373525186;967.2842096848423;1007.8135544924213;17605.823941760675;18149.546261343574;18434.723479147822;18574.164162612717;18849.717254241197;921.5069937583495;922.8477301245354;942.7548837302213;953.2469349214043;959.5298303831072;10403.791924161626;10428.374297542172;10546.314489558154;10578.62974795894;10605.310654807412;472019;478377;480849;481049;493319;74737;76863;77961.61019194868;78892;79564.60217698874;930.223263574909;970.1753509516996;1034.963776267827;1064.7338165458636;1082.5453309609982;18079.186436610646;18297.725534116733;18719.25122995065;18808.311600237776;18838.623227535645;32467.02598922036;33657;41367;41379.1724165509;42350.36474452824;59285.40714592799;59592.70203648954;61708.38291617027;61711.691441542505;61895.690521547105;8286.337093032422;8393.118722534291;8542.183901729848;8699;8790;11559;12597.622071337875;12802.16785908913;12937.482500699867;13038.543650972171;11534.423278836193;11751;11753.529858805552;11932.642020739391;11939.104567157325;10510.789784204426;10839.729006774895;11027.338359698444;11049.779004420026;11303.547858085585;11739.11956603241;11829.645110646694;11872.881271187178;11920.463579139134;12204.938975305067;7407;7638.618069096412;7720.073591169095;7961.8407631848195;8836.072212417603;11046.226764126433;11486.770264594828;11552.480138393961;11570.305781653127;11604.245724027911 05:20:50 INFO - PROCESS | 11151 | |3;mootools.html;1404.2767974493136;1418.6098822823726;1574.740167872301;1674.0876222458758;1810.131137054214;7910.485818421798;8474.703385381514;8760.737177884666;9519.096675513974;9536.904630953697;8656.17766312201;8899.332550058756;8929;8933.82132357354;8934.195922366986;2217.190725385231;2244.618414869468;2258.6499092640665;2261.1746712450004;2266.0709109265204;2223.455253462904;2236.854604450714;2260.062074239189;2285.3600991722346;2287.6797248385237;2226.8441209115367;2240.9775902241013;2244.7194100737406;2253.0874995626714;2254.5040091179912;2153.3862849088014;2157.352794161753;2167.674848772681;2175.977290673381;2186.3440967709626;2177.3903307074042;2225.3880182949656;2232.944176395587;2235.731712194547;2248.977510224893;8889.422187557788;8957.552122393854;8976.23701985332;8983.595738191732;8995.910040899573;5004.174311238641;5109.6167787415725;5110.923336149961;5118.027574760784;5119.360079990001;3007.5338322560037;3090.6600273969843;3243.4810430331268;3246.0910944935454;3246.9837650811833;1027.5376080763685;1056.8626078609732;1065.408698172514;1091.3233795047042;1096.6326280695896;12469.625911222678;12486.50053997848;12790.936045319713;12834.80747788784;13162.86837131626;4092.46797916269;4124.278251306009;4170.603792639695;4204.978975105105;4205.789710514462;9172.31207659415;9221.262299016063;9279.350445468752;9303.674371396968;9308;4983.053219888209;4993.400791904995;5001.374828146481;5014.34813474246;5015.423226329019;4095.9590404096175;4539.341795439643;4652.488226295105;4657.417822772153;4671.6262698984;3698.852045918133;3757.9812100939866;3782.6217378261954;3816.0269131371324;3952.3478626026385;1132.3206076354122;1133.7165708572857;1133.960311389114;1143.9942800285946;1146.4439746722833;1011.4285428732743;1013.7820368620781;1029.5933106422922;1037.9481025948824;1042.280826229899;6199.721012554446;6257.2491301044165;6275.1842260506755;6366.490680745622;6433.131527243856;427.3867000853785;428.6378010581054;430.4038906114991;438.69729886378934;439.1173740781053;4228;4327.805248763813;4338.219120558329;4371.366151907955;4383.167198232326;11033;11460.426978651034;11505.827412588818;11519.942400288113;11522.827157592643;11132.833007504894;11334.319940803578;11355.37545435009;11578.07375409982;11610.535578576932;8556.786080347916;8567.785805354792;8586.270167035747;8669.956650216709;8722.258608018263;6197.225346831646;6333.145025421509;6335.176427064452;6347.428731414195;6388.1376014237485;10160.593576257163;10552.841707374242;10600.0989915858;10699.465026748787;10706.8929310709;10702.625408110678;10783.460826958777;10783.892161078602;10792.244542881923;10858;6903.102596662402;7250.854982900207;7467;7507.399408047234;7520.172780994196;8672.089430609947;8707.042225355333;8737;8775.956120219358;8792.648294068165;8024.438289319692;8034.236747508978;8163.755087347389;8236.96247028984;8332.625031873458;7894.171112033384;7954;7977.082635496992;8078.23256790604;8140.511569305861;7024.227334993045;7435.367993720594;7485.214052524624;7548.509346892434;7580.583067931317;5702.942970570241;5707.68607726579;5794.855128621818;5807.186993820784;5929.495992840484;5709.229254050816;5754.625949313281;5774.220480235114;5856.326522449973;5898.911516327173 05:20:50 INFO - PROCESS | 11151 | |4;prototype.html;299.2638110248788;299.45798105429174;313.1497982976219;319.0381001281139;320.5768385730835;5619.4099619539975;5623.915641265379;5626.156076588513;5634.5068556832475;5656.208130861677;5514.889702205954;5525.530329921951;5528.917066244009;5532.502074813266;5559.527440167591;4098.344264917614;4115.518413371184;4170.728902621335;4240.724352917051;4247.617714405703;4204.810783514749;4229.259879521087;4238.766867822269;4250.447441832557;4259.78701064947;4217.43064686268;4218.91562168758;4231.809568569422;4238.9152216955645;4242.321228603424;4003.2193722224033;4189.868735441444;4202.222588821078;4205.894852628679;4217.662586993033;3634.1459756957092;3658.762180458262;3664.2121943782213;3665.7433979621437;3670.504481894963;5307.389650190239;5330.92003619946;5342.759575819097;5346.358436987547;5360.597955153379;4593.425821772278;4777.761111944424;4788.664793464459;4817.181079216542;4872.439669438025;5707.686077265748;5763.682997435139;5776.249087618625;5791;5814.389489103625;3955;3955.7428767130045;3965.8413663453425;3983.3029219886403;4001.8599349022643;5947;5955.583109182359;5985.6408615483215;6020.4280593344;6028.668423236764;4038.4548086008012;4048.5344185418467;4060.614241647039;4064.146529228895;4070.1452694933805;4131.194417088699;4141.875743727693;4153.190127925026;4154.854580089743;4161.542230354658;4708.835190768306;4762.809487620457;4800.4479484859685;4812.133815913169;4837.9032419351415;5763.308402991668;5786.04530252512;5794.768209271582;5818.5345172386105;5822.214001109881;1415.9858401415854;1418.3688258724974;1418.581518452059;1419.6229657232468;1438.1227451254726;883.0463099852144;897.6454300551246;929.869818225449;938.8921073133631;967.9467629280457;5407.324084489439;5442.12925931849;5457.617966742369;5530.419305972895;5537.640053396516;5852.385499522489;5855.414458554195;5869.882602347929;5904.380040095814;5910.586258961917;5414.675119492843;5606.822567260921;5646.898854723289;5671.404502527258;5681.77272909079;3170.7304879085073;3173.286010647632;3208.197950512372;3213.614366276062;3223.854926528312;5959.7914073008105;6109.175261339751;6155.72299246535;6161.630302181883;6200.0699895015205;5976;5986.413600395898;6024.0662697282;6032.245969253843;6041.879162416815;6136.509079273647;6154.692265386713;6161.229846269216;6166.99999999991;6168.9691551542855;5653.604247702621;5870.5010074142465;5892.793752218652;5930.584859059824;5943.197668314722;5716.9137863805745;5798.275215598051;5807.245058142415;5823.970880145742;5872.794452194153;5990.460858522754;6088.360722124113;6094.75620975156;6176.752929882934;6197.4732147767945;4017.5178978521594;4036.535798383106;4044.4337792709634;4048.3320252158064;4048.9797551012057;5937.821865344046;5953.422343079001;5969.343372229138;5982.910256346246;6020.638761674313;5528.226048353154;5740.311162660508;5745.482906538432;5761.740721667619;5802.361740208658;5692.377672363356;5711.400302968294;5733.483986441241;5776.480116789509;5799.4780469757925;5577.832665020056;5629.240052592848;5656.321241451053;5763.608102637359;5835.665733706552;5895.734691938959;5941.663125796661;5950.315713692808;5959.255093113361;5978.701064946822;5637.46444087811;5800.680962546931;5807.767689292381;5811.360750317546;5863.853403664943 05:20:50 INFO - PROCESS | 11151 | |5;yui.html;770.7880332908453;775.8409526047161;820.7455688736492;856.3149480415666;874.986875196872;14459.78310325346;15204.619884502892;15273.541793746177;15305.311260993254;15334.38662453502;12959.222446653208;13911.095778774372;14289.785653215211;14346.784798228035;14429.42282308709;786.3787607789839;794.7854079398559;803.3894240377297;803.4135081390589;803.9428151980128;805.3677862877643;807.8061265296345;814.071957967917;814.9934830484347;816.3591580609223;849.562475325208;858.1675774498757;859.6647307550061;859.879616853641;860.1269711243062;849.2823564088335;853.3130829682103;855.3670283989865;857.0829212742368;857.618359829876;625.0062400782732;625.2809269340249;625.3590070178104;626.8307556959641;627.0343670747044;13285.202887826761;13345.332733363293;13357.198568085945;13409.262490563015;13416.93291533546;12815;12899.742005159938;12954.157979731288;13080.41138148776;13387;12406.255624662459;12521.874781252161;12572.182808117443;12721.173123746927;12791.424385902563;4454.011507112055;4459.977700111511;4462.709923854939;4468;4541.114482675879;58956.64173433057;60303.09545356823;60314.698426508025;60505.69747151236;60586.09120863191;10440.530176142092;10468.162546996222;10496.842547361795;10519.579216831242;11179.608713695145;19029.61940761205;19118.42644720633;19130;19183.712244316346;19259.133338999778;8193.918060819435;8256.1331060239;8339.583020848933;8381.622826972802;8737.951445826542;4656.8137274508645;4680.625549955996;4702.482726900038;4740.004599034241;4849.393825771778;3160.2573395252098;3212.6626704195724;3214.694604012615;3227.306129182237;3237.4658181399805;574.018428487283;576.7404667899463;581.988360232793;587.4272584230426;615.7444660465857;721.3940290156189;724.5037149552574;764;765.395337683224;768.9507462612077;10161.796764064677;10407.929660750096;10450.372977621368;10518.316309439862;10628.25602207838;655.1646650520624;721.8303698630817;734.258399016986;775.7207405334075;779.980500487481;4568.314752787109;4807.206810876166;4899.902001960012;4915.09070821892;4933.210686290176;74134;74195;75760.62119689367;75941.62029189819;76032.61983690046;63549;65961.34038659552;66118.33881661217;66826;66881;54402.45597544053;56388;56841;58245.41754582485;59351;9588.712338629852;9625.181859541737;9664.468454235084;9850.359726617748;10040.849387259052;36213.818930905174;36404.81797590995;37623;38116;38132.80933595314;50203.24695129649;50298.49701502938;50868.74565627148;51189.74405127951;52052.739736301075;11559.364234967157;11594.594189203337;11663.24188927717;12396.628101156979;12773.23360598367;14079.577612671636;14138.717225655635;14394.984702141499;14402.567922962327;14449.422023118957;13581.86418135806;13584.437789654316;13613.931930340284;13619.114757540729;14176.149431034171;12969.221846689228;13253.933730331286;13307.201567905957;13320.800187996994;13334.26661533625;13058.542950996669;13105.606831795061;13148.211107333591;13286.601401957956;13401.396937138048;10886;10967;10968.17738669587;11000.614978475714;11274.887251127384;11007;11037.337759734442;11117.166212534254;11232.719182020515;11469.369184694922 05:20:50 INFO - PROCESS | 11151 | __end_tp_report 05:20:50 INFO - PROCESS | 11151 | __start_cc_report 05:20:50 INFO - PROCESS | 11151 | _x_x_mozilla_cycle_collect,338 05:20:50 INFO - PROCESS | 11151 | __end_cc_report 05:20:50 INFO - PROCESS | 11151 | __startTimestamp1464438050549__endTimestamp 05:20:50 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | ------- Summary: start ------- 05:20:50 INFO - PROCESS | 11151 | Number of tests: 6 05:20:50 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | [#0] dojo.html Cycles:165 Average:5443.41 Median:5681.72 stddev:737.57 (13.0%) stddev-sans-first:716.95 05:20:50 INFO - PROCESS | 11151 | Values: 3119.4 3156.2 3162.1 3167.2 3201.6 5418.3 5464.3 5502.9 5542.8 5552.8 5354.3 5406.4 5429.5 5473.6 5565.8 4900.1 4948.0 5048.1 5086.1 5152.1 721.0 4850.3 4935.5 5003.3 5056.2 4912.9 4946.4 4979.0 4979.6 4981.4 4993.1 5015.9 5017.0 5018.7 5027.5 4933.3 4965.2 4979.2 5000.5 5006.4 5352.7 5353.6 5382.8 5407.8 5435.7 5635.3 5781.0 5843.8 5917.9 5924.3 5838.5 5886.2 5893.4 5939.0 5983.8 5504.0 5509.4 5517.2 5517.7 5518.1 5823.6 5941.2 5964.5 6047.5 6049.2 5729.4 5733.9 5736.8 5745.1 5750.8 5906.9 5912.6 5913.9 5916.2 5924.1 5854.9 5884.7 5889.0 5914.7 5954.7 5909.5 5924.9 5936.2 5946.2 5960.9 4402.5 4502.6 4505.6 4508.5 4551.0 3902.8 3934.1 3968.4 4000.3 4001.3 5556.9 5571.9 5637.9 5648.3 5681.7 5791.8 5931.6 5960.4 5965.9 5967.6 5599.6 5639.0 5650.7 5675.5 5682.0 5005.9 5056.5 5066.3 5081.4 5094.7 5947.6 6091.6 6205.6 6209.9 6225.4 5859.7 6001.2 6003.1 6008.7 6056.7 6121.7 6163.8 6200.9 6211.1 6218.3 5586.4 5768.7 5798.4 5876.6 5877.8 5931.9 5984.9 5990.0 5995.8 6003.2 5722.5 5733.7 5761.9 5764.9 5776.8 5518.7 5677.8 5696.3 5713.0 5746.3 5657.7 5714.7 5735.1 5748.0 5760.6 5832.8 5836.0 5840.4 5854.6 5872.9 5510.0 5573.8 5574.2 5612.9 5658.4 05:20:50 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | [#1] ext.html Cycles:180 Average:56209.24 Median:199326.50 stddev:110833.74 (55.6%) stddev-sans-first:111065.98 05:20:50 INFO - PROCESS | 11151 | Values: 587.7 620.3 634.8 646.0 672.2 39248.4 40975.2 44698.0 44835.6 44862.6 45796.0 46422.8 46509.8 46578.3 46679.5 8855.2 8955.8 9010.1 9026.4 9027.1 8872.4 8897.0 8939.0 8958.4 8990.6 8946.6 9027.0 9031.1 9044.1 9044.4 8953.9 9004.9 9021.0 9021.8 9022.1 8847.2 8928.6 8981.6 8991.8 8999.7 29663.0 42461.0 43276.4 43323.8 43346.8 3266.3 3325.7 3593.7 3619.9 4248.4 30380.1 30561.7 30750.7 30760.1 30932.7 3939.1 3960.0 3967.4 3968.7 4202.6 296793.0 296870.5 298201.0 298433.0 299999.0 35666.8 35964.1 36123.5 36154.1 36189.5 36313.0 37077.3 37260.4 38168.0 38363.4 15039.0 15098.0 15180.8 15202.2 15224.7 13041.7 13052.7 13097.9 13150.1 13167.0 19765.8 19799.5 19914.5 19924.8 20153.3 7088.4 7296.5 7397.7 7426.8 7433.7 939.9 986.8 1039.1 1156.0 1181.9 28981.1 29098.7 29156.3 29638.7 29678.4 1094.4 1108.4 1154.2 1193.3 1237.4 16815.5 17391.4 17423.0 17487.2 17736.1 521826.0 529450.0 529909.0 531960.0 534655.0 59835.4 60137.7 60327.0 60449.0 60765.4 1236.7 1319.3 1390.4 1396.2 1406.4 30889.2 32354.7 32746.3 32809.3 33075.8 50971.2 51314.2 51404.0 51614.2 51785.0 391109.0 392795.0 393586.0 393958.0 394693.0 28421.3 28472.4 28913.3 28963.3 29223.0 48567.8 48692.8 49143.0 49297.5 49696.8 42100.8 42587.0 42621.6 42964.4 43445.3 41940.2 42165.4 42279.5 42329.0 42416.6 32728.2 40425.0 41252.4 42163.6 42806.0 35937.8 36851.0 37087.8 37877.8 38012.8 25780.7 25819.7 25938.5 26107.9 26221.8 05:20:50 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | [#2] jquery.html Cycles:180 Average:28298.00 Median:17016.06 stddev:79074.18 (464.7%) stddev-sans-first:79268.21 05:20:50 INFO - PROCESS | 11151 | Values: 375.1 386.3 390.8 394.6 410.7 18037.6 19628.1 20199.2 20573.7 20589.5 17198.2 17373.4 17607.3 18519.7 19286.3 5525.9 5604.4 5695.5 5747.4 5763.6 5613.2 5653.7 5671.1 5671.3 5677.9 5600.5 5604.5 5611.1 5614.8 5636.5 5598.3 5619.7 5625.8 5632.5 5656.5 4864.8 4909.6 5019.2 5059.9 5080.5 22673.8 22930.3 22979.0 23124.5 23160.9 2401.6 2435.0 2478.7 2530.9 2933.9 13892.2 14152.3 14245.7 14315.7 14902.4 1917.5 1996.0 1998.6 2028.7 2064.8 75282.0 78748.0 79376.2 80056.6 80628.4 10245.2 10258.2 10521.6 10681.0 10781.6 14647.8 14651.6 14665.4 14672.0 14710.2 7463.7 7721.0 7754.4 7809.2 8033.3 7417.3 7523.0 7698.0 7762.6 7819.5 6440.2 6445.3 6693.8 6694.9 6698.5 1868.0 1941.5 1944.7 1962.8 1968.6 904.3 923.9 933.8 967.3 1007.8 17605.8 18149.5 18434.7 18574.2 18849.7 921.5 922.8 942.8 953.2 959.5 10403.8 10428.4 10546.3 10578.6 10605.3 472019.0 478377.0 480849.0 481049.0 493319.0 74737.0 76863.0 77961.6 78892.0 79564.6 930.2 970.2 1035.0 1064.7 1082.5 18079.2 18297.7 18719.3 18808.3 18838.6 32467.0 33657.0 41367.0 41379.2 42350.4 59285.4 59592.7 61708.4 61711.7 61895.7 8286.3 8393.1 8542.2 8699.0 8790.0 11559.0 12597.6 12802.2 12937.5 13038.5 11534.4 11751.0 11753.5 11932.6 11939.1 10510.8 10839.7 11027.3 11049.8 11303.5 11739.1 11829.6 11872.9 11920.5 12204.9 7407.0 7638.6 7720.1 7961.8 8836.1 11046.2 11486.8 11552.5 11570.3 11604.2 05:20:50 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | [#3] mootools.html Cycles:180 Average:5882.23 Median:4333.01 stddev:3457.79 (79.8%) stddev-sans-first:3451.12 05:20:50 INFO - PROCESS | 11151 | Values: 1404.3 1418.6 1574.7 1674.1 1810.1 7910.5 8474.7 8760.7 9519.1 9536.9 8656.2 8899.3 8929.0 8933.8 8934.2 2217.2 2244.6 2258.6 2261.2 2266.1 2223.5 2236.9 2260.1 2285.4 2287.7 2226.8 2241.0 2244.7 2253.1 2254.5 2153.4 2157.4 2167.7 2176.0 2186.3 2177.4 2225.4 2232.9 2235.7 2249.0 8889.4 8957.6 8976.2 8983.6 8995.9 5004.2 5109.6 5110.9 5118.0 5119.4 3007.5 3090.7 3243.5 3246.1 3247.0 1027.5 1056.9 1065.4 1091.3 1096.6 12469.6 12486.5 12790.9 12834.8 13162.9 4092.5 4124.3 4170.6 4205.0 4205.8 9172.3 9221.3 9279.4 9303.7 9308.0 4983.1 4993.4 5001.4 5014.3 5015.4 4096.0 4539.3 4652.5 4657.4 4671.6 3698.9 3758.0 3782.6 3816.0 3952.3 1132.3 1133.7 1134.0 1144.0 1146.4 1011.4 1013.8 1029.6 1037.9 1042.3 6199.7 6257.2 6275.2 6366.5 6433.1 427.4 428.6 430.4 438.7 439.1 4228.0 4327.8 4338.2 4371.4 4383.2 11033.0 11460.4 11505.8 11519.9 11522.8 11132.8 11334.3 11355.4 11578.1 11610.5 8556.8 8567.8 8586.3 8670.0 8722.3 6197.2 6333.1 6335.2 6347.4 6388.1 10160.6 10552.8 10600.1 10699.5 10706.9 10702.6 10783.5 10783.9 10792.2 10858.0 6903.1 7250.9 7467.0 7507.4 7520.2 8672.1 8707.0 8737.0 8776.0 8792.6 8024.4 8034.2 8163.8 8237.0 8332.6 7894.2 7954.0 7977.1 8078.2 8140.5 7024.2 7435.4 7485.2 7548.5 7580.6 5702.9 5707.7 5794.9 5807.2 5929.5 5709.2 5754.6 5774.2 5856.3 5898.9 05:20:50 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | [#4] prototype.html Cycles:180 Average:4833.74 Median:5625.04 stddev:1460.82 (26.0%) stddev-sans-first:1424.72 05:20:50 INFO - PROCESS | 11151 | Values: 299.3 299.5 313.1 319.0 320.6 5619.4 5623.9 5626.2 5634.5 5656.2 5514.9 5525.5 5528.9 5532.5 5559.5 4098.3 4115.5 4170.7 4240.7 4247.6 4204.8 4229.3 4238.8 4250.4 4259.8 4217.4 4218.9 4231.8 4238.9 4242.3 4003.2 4189.9 4202.2 4205.9 4217.7 3634.1 3658.8 3664.2 3665.7 3670.5 5307.4 5330.9 5342.8 5346.4 5360.6 4593.4 4777.8 4788.7 4817.2 4872.4 5707.7 5763.7 5776.2 5791.0 5814.4 3955.0 3955.7 3965.8 3983.3 4001.9 5947.0 5955.6 5985.6 6020.4 6028.7 4038.5 4048.5 4060.6 4064.1 4070.1 4131.2 4141.9 4153.2 4154.9 4161.5 4708.8 4762.8 4800.4 4812.1 4837.9 5763.3 5786.0 5794.8 5818.5 5822.2 1416.0 1418.4 1418.6 1419.6 1438.1 883.0 897.6 929.9 938.9 967.9 5407.3 5442.1 5457.6 5530.4 5537.6 5852.4 5855.4 5869.9 5904.4 5910.6 5414.7 5606.8 5646.9 5671.4 5681.8 3170.7 3173.3 3208.2 3213.6 3223.9 5959.8 6109.2 6155.7 6161.6 6200.1 5976.0 5986.4 6024.1 6032.2 6041.9 6136.5 6154.7 6161.2 6167.0 6169.0 5653.6 5870.5 5892.8 5930.6 5943.2 5716.9 5798.3 5807.2 5824.0 5872.8 5990.5 6088.4 6094.8 6176.8 6197.5 4017.5 4036.5 4044.4 4048.3 4049.0 5937.8 5953.4 5969.3 5982.9 6020.6 5528.2 5740.3 5745.5 5761.7 5802.4 5692.4 5711.4 5733.5 5776.5 5799.5 5577.8 5629.2 5656.3 5763.6 5835.7 5895.7 5941.7 5950.3 5959.3 5978.7 5637.5 5800.7 5807.8 5811.4 5863.9 05:20:50 INFO - PROCESS | 11151 | 05:20:50 INFO - PROCESS | 11151 | [#5] yui.html Cycles:180 Average:16267.20 Median:4554.71 stddev:19936.50 (437.7%) stddev-sans-first:19958.46 05:20:50 INFO - PROCESS | 11151 | Values: 770.8 775.8 820.7 856.3 875.0 14459.8 15204.6 15273.5 15305.3 15334.4 12959.2 13911.1 14289.8 14346.8 14429.4 786.4 794.8 803.4 803.4 803.9 805.4 807.8 814.1 815.0 816.4 849.6 858.2 859.7 859.9 860.1 849.3 853.3 855.4 857.1 857.6 625.0 625.3 625.4 626.8 627.0 13285.2 13345.3 13357.2 13409.3 13416.9 12815.0 12899.7 12954.2 13080.4 13387.0 12406.3 12521.9 12572.2 12721.2 12791.4 4454.0 4460.0 4462.7 4468.0 4541.1 58956.6 60303.1 60314.7 60505.7 60586.1 10440.5 10468.2 10496.8 10519.6 11179.6 19029.6 19118.4 19130.0 19183.7 19259.1 8193.9 8256.1 8339.6 8381.6 8738.0 4656.8 4680.6 4702.5 4740.0 4849.4 3160.3 3212.7 3214.7 3227.3 3237.5 574.0 576.7 582.0 587.4 615.7 721.4 724.5 764.0 765.4 769.0 10161.8 10407.9 10450.4 10518.3 10628.3 655.2 721.8 734.3 775.7 780.0 4568.3 4807.2 4899.9 4915.1 4933.2 74134.0 74195.0 75760.6 75941.6 76032.6 63549.0 65961.3 66118.3 66826.0 66881.0 54402.5 56388.0 56841.0 58245.4 59351.0 9588.7 9625.2 9664.5 9850.4 10040.8 36213.8 36404.8 37623.0 38116.0 38132.8 50203.2 50298.5 50868.7 51189.7 52052.7 11559.4 11594.6 11663.2 12396.6 12773.2 14079.6 14138.7 14395.0 14402.6 14449.4 13581.9 13584.4 13613.9 13619.1 14176.1 12969.2 13253.9 13307.2 13320.8 13334.3 13058.5 13105.6 13148.2 13286.6 13401.4 10886.0 10967.0 10968.2 11000.6 11274.9 11007.0 11037.3 11117.2 11232.7 11469.4 05:20:50 INFO - PROCESS | 11151 | -------- Summary: end -------- 05:20:50 INFO - PROCESS | 11151 | 05:20:51 INFO - TEST-INFO | 11151: exit 0 05:20:51 INFO - TEST-OK | dromaeo_css | took 1109758ms 05:20:51 INFO - TEST-START | kraken 05:20:51 INFO - operating with platform_type : linux_ 05:20:51 INFO - Initialising browser for kraken test... 05:20:51 INFO - TEST-INFO | started process 11388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGmu1h5/profile http://localhost:42022/getInfo.html) 05:20:54 INFO - PROCESS | 11388 | 05:20:54 INFO - PROCESS | 11388 | (process:11458): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:20:55 INFO - PROCESS | 11388 | __metrics Screen width/height:1600/1200 05:20:55 INFO - PROCESS | 11388 | colorDepth:24 05:20:55 INFO - PROCESS | 11388 | Browser inner width/height: 1024/697 05:20:55 INFO - PROCESS | 11388 | __metrics 05:20:56 ERROR - PROCESS | 11388 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:20:57 INFO - TEST-INFO | 11388: exit 0 05:20:57 INFO - Browser initialized. 05:20:57 INFO - Running cycle 1/1 for kraken test... 05:20:57 INFO - TEST-INFO | started process 11509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGmu1h5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:58 INFO - PROCESS | 11509 | 05:20:58 INFO - PROCESS | 11509 | (process:11571): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:21:08 INFO - PROCESS | 11509 | RSS: Main: 166313984 05:21:08 INFO - PROCESS | 11509 | 05:21:11 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42022/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:12 INFO - PROCESS | 11509 | RSS: Main: 172146688 05:21:12 INFO - PROCESS | 11509 | 05:21:15 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42022/tests/kraken/driver.html?testName=audio-dft) 05:21:15 INFO - PROCESS | 11509 | RSS: Main: 171413504 05:21:15 INFO - PROCESS | 11509 | 05:21:18 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42022/tests/kraken/driver.html?testName=audio-fft) 05:21:19 INFO - PROCESS | 11509 | RSS: Main: 165928960 05:21:19 INFO - PROCESS | 11509 | 05:21:21 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42022/tests/kraken/driver.html?testName=audio-oscillator) 05:21:21 INFO - PROCESS | 11509 | RSS: Main: 166883328 05:21:21 INFO - PROCESS | 11509 | 05:21:24 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42022/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:24 INFO - PROCESS | 11509 | RSS: Main: 167219200 05:21:24 INFO - PROCESS | 11509 | 05:21:27 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42022/tests/kraken/driver.html?testName=imaging-darkroom) 05:21:28 INFO - PROCESS | 11509 | RSS: Main: 167161856 05:21:28 INFO - PROCESS | 11509 | 05:21:31 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42022/tests/kraken/driver.html?testName=imaging-desaturate) 05:21:32 INFO - PROCESS | 11509 | RSS: Main: 167436288 05:21:32 INFO - PROCESS | 11509 | 05:21:35 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42022/tests/kraken/driver.html?testName=json-parse-financial) 05:21:35 INFO - PROCESS | 11509 | RSS: Main: 168169472 05:21:35 INFO - PROCESS | 11509 | 05:21:37 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42022/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:21:37 INFO - PROCESS | 11509 | RSS: Main: 167469056 05:21:37 INFO - PROCESS | 11509 | 05:21:39 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42022/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:21:40 INFO - PROCESS | 11509 | RSS: Main: 168022016 05:21:40 INFO - PROCESS | 11509 | 05:21:42 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42022/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:21:43 INFO - PROCESS | 11509 | RSS: Main: 168456192 05:21:43 INFO - PROCESS | 11509 | 05:21:45 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42022/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:21:46 INFO - PROCESS | 11509 | RSS: Main: 168837120 05:21:46 INFO - PROCESS | 11509 | 05:21:49 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42022/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:21:49 INFO - PROCESS | 11509 | RSS: Main: 168480768 05:21:49 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | Cycle 1(1): loaded http://localhost:42022/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42022/tests/kraken/driver.html?testName=ai-astar) 05:21:51 INFO - PROCESS | 11509 | RSS: Main: 169160704 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | __start_tp_report 05:21:51 INFO - PROCESS | 11509 | _x_x_mozilla_page_load 05:21:51 INFO - PROCESS | 11509 | _x_x_mozilla_page_load_details 05:21:51 INFO - PROCESS | 11509 | |i|pagename|runs| 05:21:51 INFO - PROCESS | 11509 | |0;ai-astar;111;106;111;112;112;114;110;111;110;112 05:21:51 INFO - PROCESS | 11509 | |1;audio-beat-detection;151;129;166;176;129;169;152;134;186;136 05:21:51 INFO - PROCESS | 11509 | |2;audio-dft;164;162;170;162;163;163;176;162;161;163 05:21:51 INFO - PROCESS | 11509 | |3;audio-fft;76;74;75;163;76;74;74;74;168;79 05:21:51 INFO - PROCESS | 11509 | |4;audio-oscillator;83;83;148;83;82;83;138;83;83;138 05:21:51 INFO - PROCESS | 11509 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;118;118;118 05:21:51 INFO - PROCESS | 11509 | |6;imaging-darkroom;147;147;147;147;147;146;145;146;147;146 05:21:51 INFO - PROCESS | 11509 | |7;imaging-desaturate;96;96;95;95;95;95;95;96;95;96 05:21:51 INFO - PROCESS | 11509 | |8;json-parse-financial;56;57;56;56;57;55;58;63;54;55 05:21:51 INFO - PROCESS | 11509 | |9;json-stringify-tinderbox;67;68;64;63;64;61;63;63;63;63 05:21:51 INFO - PROCESS | 11509 | |10;stanford-crypto-aes;80;81;79;79;81;80;80;83;118;80 05:21:51 INFO - PROCESS | 11509 | |11;stanford-crypto-ccm;126;127;124;130;121;120;134;135;137;120 05:21:51 INFO - PROCESS | 11509 | |12;stanford-crypto-pbkdf2;168;158;161;160;162;162;162;161;159;158 05:21:51 INFO - PROCESS | 11509 | |13;stanford-crypto-sha256-iterative;63;63;64;65;68;62;65;62;65;62 05:21:51 INFO - PROCESS | 11509 | __end_tp_report 05:21:51 INFO - PROCESS | 11509 | __start_cc_report 05:21:51 INFO - PROCESS | 11509 | _x_x_mozilla_cycle_collect,916 05:21:51 INFO - PROCESS | 11509 | __end_cc_report 05:21:51 INFO - PROCESS | 11509 | __startTimestamp1464438111628__endTimestamp 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | ------- Summary: start ------- 05:21:51 INFO - PROCESS | 11509 | Number of tests: 14 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.08 (1.9%) stddev-sans-first:2.20 05:21:51 INFO - PROCESS | 11509 | Values: 111.0 106.0 111.0 112.0 112.0 114.0 110.0 111.0 110.0 112.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:159.00 stddev:20.68 (13.0%) stddev-sans-first:21.93 05:21:51 INFO - PROCESS | 11509 | Values: 151.0 129.0 166.0 176.0 129.0 169.0 152.0 134.0 186.0 136.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.00 stddev:4.72 (2.9%) stddev-sans-first:5.00 05:21:51 INFO - PROCESS | 11509 | Values: 164.0 162.0 170.0 162.0 163.0 163.0 176.0 162.0 161.0 163.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#3] audio-fft Cycles:10 Average:93.30 Median:74.50 stddev:38.10 (51.1%) stddev-sans-first:39.90 05:21:51 INFO - PROCESS | 11509 | Values: 76.0 74.0 75.0 163.0 76.0 74.0 74.0 74.0 168.0 79.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#4] audio-oscillator Cycles:10 Average:100.40 Median:83.00 stddev:28.38 (34.2%) stddev-sans-first:29.39 05:21:51 INFO - PROCESS | 11509 | Values: 83.0 83.0 148.0 83.0 82.0 83.0 138.0 83.0 83.0 138.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:21:51 INFO - PROCESS | 11509 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:21:51 INFO - PROCESS | 11509 | Values: 147.0 147.0 147.0 147.0 147.0 146.0 145.0 146.0 147.0 146.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:21:51 INFO - PROCESS | 11509 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:2.50 (4.4%) stddev-sans-first:2.64 05:21:51 INFO - PROCESS | 11509 | Values: 56.0 57.0 56.0 56.0 57.0 55.0 58.0 63.0 54.0 55.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:63.50 stddev:2.08 (3.3%) stddev-sans-first:1.88 05:21:51 INFO - PROCESS | 11509 | Values: 67.0 68.0 64.0 63.0 64.0 61.0 63.0 63.0 63.0 63.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:80.00 stddev:11.97 (15.0%) stddev-sans-first:12.60 05:21:51 INFO - PROCESS | 11509 | Values: 80.0 81.0 79.0 79.0 81.0 80.0 80.0 83.0 118.0 80.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.50 stddev:6.36 (5.0%) stddev-sans-first:6.73 05:21:51 INFO - PROCESS | 11509 | Values: 126.0 127.0 124.0 130.0 121.0 120.0 134.0 135.0 137.0 120.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:161.50 stddev:2.88 (1.8%) stddev-sans-first:1.66 05:21:51 INFO - PROCESS | 11509 | Values: 168.0 158.0 161.0 160.0 162.0 162.0 162.0 161.0 159.0 158.0 05:21:51 INFO - PROCESS | 11509 | 05:21:51 INFO - PROCESS | 11509 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.91 (3.0%) stddev-sans-first:2.00 05:21:51 INFO - PROCESS | 11509 | Values: 63.0 63.0 64.0 65.0 68.0 62.0 65.0 62.0 65.0 62.0 05:21:51 INFO - PROCESS | 11509 | -------- Summary: end -------- 05:21:51 INFO - PROCESS | 11509 | 05:21:52 INFO - TEST-INFO | 11509: exit 0 05:21:52 INFO - TEST-OK | kraken | took 61411ms 05:21:52 INFO - SUITE-END | took 1171s 05:21:52 INFO - Completed test suite (00:19:31) 05:21:52 INFO - javascript benchmark 05:21:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7161.65302787478, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.4073126106036, 3156.1793933577264, 3162.114607909785, 3167.2081979505124, 3201.5998000249983, 5418.322709661293, 5464.344278686558, 5502.944970550293, 5542.7782888684405, 5552.77788888445, 5354.2771725817, 5406.432324605909, 5429.4570542945685, 5473.616846820724, 5565.777368905239, 4900.11797876383, 4947.950520494803, 5048.141815891289, 5086.059079070384, 5152.098382783017, 720.9649760799558, 4850.2724591311235, 4935.506449355072, 5003.274525193845, 5056.216286475602, 4912.852614421573, 4946.431160416544, 4978.950210497885, 4979.626528010395, 4981.402231732197, 4993.1262029144755, 5015.949840501621, 5017.046761115376, 5018.673786203885, 5027.49725027498, 4933.28467372229, 4965.205567109245, 4979.1784355581285, 5000.524950129732, 5006.374203224597, 5352.652077614943, 5353.625246232766, 5382.811601593965, 5407.783688652449, 5435.728213589305, 5635.3237611486475, 5780.971095144498, 5843.766249350021, 5917.881642367129, 5924.289085309747, 5838.503727183194, 5886.175935369051, 5893.440123188333, 5938.970305148447, 5983.790567330166, 5504.036793561111, 5509.393966663663, 5517.227588137664, 5517.668939863621, 5518.089515229983, 5823.621464604787, 5941.227640406806, 5964.522838172936, 6047.516198704093, 6049.243844519435, 5729.369769325371, 5733.8566535836935, 5736.799212027559, 5745.052066409079, 5750.769969201268, 5906.940930590725, 5912.645241285537, 5913.852153696106, 5916.201312822714, 5924.081767325985, 5854.912176317359, 5884.705764711747, 5889.0, 5914.6746928918465, 5954.732037058343, 5909.497692696169, 5924.851878702981, 5936.168936348915, 5946.226990491208, 5960.910586341209, 4402.471703395549, 4502.57225563571, 4505.594496495331, 4508.481524624644, 4550.97724511382, 3902.785346805953, 3934.075492259317, 3968.3849003404516, 4000.299947509174, 4001.2597669431248, 5556.861078473071, 5571.860703482364, 5637.915431268534, 5648.293963254593, 5681.715914204356, 5791.82624521265, 5931.614445061057, 5960.403959604005, 5965.850853728692, 5967.582269241198, 5599.552035837123, 5639.0, 5650.74571644277, 5675.517581005661, 5681.971590142023, 5005.949940500548, 5056.519630635084, 5066.290719299301, 5081.441041485434, 5094.719790411563, 5947.5539334550085, 6091.604045737013, 6205.565610407228, 6209.9068513972325, 6225.408586184305, 5859.677717725481, 6001.159837622824, 6003.129546215861, 6008.669523176267, 6056.666883321372, 6121.663308518075, 6163.8150855474405, 6200.875982480416, 6211.09939058843, 6218.253809542703, 5586.357568879631, 5768.711564421678, 5798.391168927202, 5876.6180198286975, 5877.823665290048, 5931.851703707269, 5984.850378740566, 5989.9700501498955, 5995.760169593167, 6003.159557661844, 5722.484976352148, 5733.741981610921, 5761.8559536011935, 5764.913526297025, 5776.844631073718, 5518.668879867221, 5677.772889084556, 5696.287964004499, 5712.971665100322, 5746.339170995389, 5657.660540367427, 5714.685692286964, 5735.053716136791, 5748.0, 5760.567957403296, 5832.825015249549, 5835.978703726746, 5840.415958404125, 5854.619449735754, 5872.941270587239, 5510.008198524304, 5573.832785016456, 5574.191742197439, 5612.85967850807, 5658.377578466283], "value": 5394.0266746388, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.6503480429143, 620.2680836612798, 634.7556190866518, 645.9903101453477, 672.2101530701431, 39248.41127383088, 40975.180496390094, 44698.0, 44835.551644483545, 44862.55137448625, 45796.0, 46422.76788616052, 46509.767451162785, 46578.30132548015, 46679.53320466794, 8855.203031727144, 8955.820883582357, 9010.14403631654, 9026.413283136608, 9027.142421469982, 8872.423292485968, 8897.0, 8938.955305223464, 8958.37291389603, 8990.640374385017, 8946.642134314652, 9027.0, 9031.142041506046, 9044.050374710627, 9044.412113212653, 8953.865692014626, 9004.909950900505, 9021.0, 9021.819563608691, 9022.052684468103, 8847.20375166238, 8928.553572321423, 8981.640734370683, 8991.775205619846, 8999.685011024583, 29663.0, 42461.0, 43276.350854737204, 43323.78338108321, 43346.78326608378, 3266.3304022675534, 3325.6508066653137, 3593.730470214718, 3619.873304434332, 4248.362745588156, 30380.088597341895, 30561.69438305633, 30750.692493075006, 30760.077197684106, 30932.690673093206, 3939.1333906540517, 3960.0, 3967.3652215645648, 3968.6626636735914, 4202.600752928467, 296793.0, 296870.546941796, 298201.0, 298433.0, 299999.0, 35666.82166589202, 35964.10089747777, 36123.4581481278, 36154.09614759652, 36189.45715814265, 36313.0, 37077.25845483075, 37260.44109338362, 38168.0, 38363.424548631796, 15039.0, 15098.0, 15180.848191517944, 15202.239888005777, 15224.695506090038, 13041.739165216643, 13052.673683157996, 13097.934510327388, 13150.145240559525, 13167.0, 19765.802341976683, 19799.505012374517, 19914.50213744668, 19924.800751992585, 20153.294634687714, 7088.432925365958, 7296.452766042568, 7397.743688175051, 7426.814329641802, 7433.739819106306, 939.9013103624021, 986.753311672082, 1039.1219419590434, 1155.9711007224887, 1181.8699943006263, 28981.142542958234, 29098.7090129096, 29156.27109322284, 29638.703612963593, 29678.40643187124, 1094.3871431998107, 1108.3737688206138, 1154.186298659443, 1193.26614132308, 1237.4161073825517, 16815.495535133967, 17391.391301304393, 17423.0, 17487.213075411637, 17736.113194340232, 521826.0, 529450.0, 529909.0, 531960.0, 534655.0, 59835.40164598385, 60137.699311503166, 60327.0, 60449.0, 60765.39234607686, 1236.6970092327438, 1319.2546211390725, 1390.4090761426353, 1396.2320723602181, 1406.3882211238144, 30889.227769305948, 32354.676453235166, 32746.34507309888, 32809.343813124084, 33075.83462082771, 50971.235431467816, 51314.23028654648, 51404.0, 51614.225786613984, 51785.0, 391109.0, 392795.0, 393586.0, 393958.0, 394693.0, 28421.289467763472, 28472.430551389272, 28913.277168070967, 28963.275918102216, 29223.0, 48567.757161215384, 48692.75653621851, 49143.0, 49297.50702492929, 49696.75151624363, 42100.789496052326, 42587.0, 42621.57378426176, 42964.35553466763, 43445.348319774595, 41940.16119677528, 42165.367519486615, 42279.509093360975, 42329.0, 42416.575834242496, 32728.18179545435, 40425.0, 41252.38121428121, 42163.578364215966, 42806.0, 35937.82031089828, 36851.0, 37087.81456092702, 37877.81061094677, 38012.80993595014, 25780.742192577833, 25819.741802581735, 25938.48123037491, 26107.869460652575, 26221.781566531165], "value": 19480.336204481133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.1296990980924, 386.2583839029064, 390.7655406755945, 394.62313490616447, 410.6960848971762, 18037.564928734617, 19628.116734746935, 20199.19203231869, 20573.691394629073, 20589.485262868417, 17198.226079826407, 17373.391931282407, 17607.29570817169, 18519.72220416695, 19286.32497862575, 5525.917111243334, 5604.41153678864, 5695.515881150107, 5747.3677895431465, 5763.596548241625, 5613.186088017235, 5653.717314134297, 5671.149327600851, 5671.319441667006, 5677.886442271152, 5600.52395546377, 5604.495595396414, 5611.130274807411, 5614.831555053355, 5636.520895723868, 5598.300212473441, 5619.662820230778, 5625.831225063254, 5632.549396048306, 5656.462636049569, 4864.805407783684, 4909.631777616693, 5019.247112933089, 5059.949400505985, 5080.542751152377, 22673.773262267496, 22930.312090637308, 22979.0, 23124.53750924989, 23160.88419557908, 2401.615741481372, 2435.0, 2478.7397323281157, 2530.9493810123695, 2933.9413211735646, 13892.23592702401, 14152.29238538069, 14245.715085698228, 14315.713685726227, 14902.403903843833, 1917.4631103291101, 1996.0, 1998.6202621501868, 2028.7058376535467, 2064.8038436348525, 75282.0, 78748.0, 79376.20623793804, 80056.59971700162, 80628.38743225162, 10245.180385569136, 10258.230632702427, 10521.631742888962, 10681.0, 10781.568737250578, 14647.780283295759, 14651.633709157144, 14665.413383464755, 14672.0, 14710.19093949843, 7463.738769143054, 7721.0, 7754.418418618626, 7809.180036096128, 8033.317168040665, 7417.33244008031, 7523.0, 7697.961510192413, 7762.5730584818375, 7819.452638315377, 6440.194975628046, 6445.323241059715, 6693.765718199839, 6694.899576506356, 6698.531102822755, 1867.9906600466911, 1941.5437372217518, 1944.6694062009492, 1962.8037196280543, 1968.5669152786363, 904.2856143646577, 923.8706581078654, 933.8132373525186, 967.2842096848423, 1007.8135544924213, 17605.823941760675, 18149.546261343574, 18434.723479147822, 18574.164162612717, 18849.717254241197, 921.5069937583495, 922.8477301245354, 942.7548837302213, 953.2469349214043, 959.5298303831072, 10403.791924161626, 10428.374297542172, 10546.314489558154, 10578.62974795894, 10605.310654807412, 472019.0, 478377.0, 480849.0, 481049.0, 493319.0, 74737.0, 76863.0, 77961.61019194868, 78892.0, 79564.60217698874, 930.223263574909, 970.1753509516996, 1034.963776267827, 1064.7338165458636, 1082.5453309609982, 18079.186436610646, 18297.725534116733, 18719.25122995065, 18808.311600237776, 18838.623227535645, 32467.02598922036, 33657.0, 41367.0, 41379.1724165509, 42350.36474452824, 59285.40714592799, 59592.70203648954, 61708.38291617027, 61711.691441542505, 61895.690521547105, 8286.337093032422, 8393.118722534291, 8542.183901729848, 8699.0, 8790.0, 11559.0, 12597.622071337875, 12802.16785908913, 12937.482500699867, 13038.543650972171, 11534.423278836193, 11751.0, 11753.529858805552, 11932.642020739391, 11939.104567157325, 10510.789784204426, 10839.729006774895, 11027.338359698444, 11049.779004420026, 11303.547858085585, 11739.11956603241, 11829.645110646694, 11872.881271187178, 11920.463579139134, 12204.938975305067, 7407.0, 7638.618069096412, 7720.073591169095, 7961.8407631848195, 8836.072212417603, 11046.226764126433, 11486.770264594828, 11552.480138393961, 11570.305781653127, 11604.245724027911], "value": 9180.580131460041, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.2767974493136, 1418.6098822823726, 1574.740167872301, 1674.0876222458758, 1810.131137054214, 7910.485818421798, 8474.703385381514, 8760.737177884666, 9519.096675513974, 9536.904630953697, 8656.17766312201, 8899.332550058756, 8929.0, 8933.82132357354, 8934.195922366986, 2217.190725385231, 2244.618414869468, 2258.6499092640665, 2261.1746712450004, 2266.0709109265204, 2223.455253462904, 2236.854604450714, 2260.062074239189, 2285.3600991722346, 2287.6797248385237, 2226.8441209115367, 2240.9775902241013, 2244.7194100737406, 2253.0874995626714, 2254.5040091179912, 2153.3862849088014, 2157.352794161753, 2167.674848772681, 2175.977290673381, 2186.3440967709626, 2177.3903307074042, 2225.3880182949656, 2232.944176395587, 2235.731712194547, 2248.977510224893, 8889.422187557788, 8957.552122393854, 8976.23701985332, 8983.595738191732, 8995.910040899573, 5004.174311238641, 5109.6167787415725, 5110.923336149961, 5118.027574760784, 5119.360079990001, 3007.5338322560037, 3090.6600273969843, 3243.4810430331268, 3246.0910944935454, 3246.9837650811833, 1027.5376080763685, 1056.8626078609732, 1065.408698172514, 1091.3233795047042, 1096.6326280695896, 12469.625911222678, 12486.50053997848, 12790.936045319713, 12834.80747788784, 13162.86837131626, 4092.46797916269, 4124.278251306009, 4170.603792639695, 4204.978975105105, 4205.789710514462, 9172.31207659415, 9221.262299016063, 9279.350445468752, 9303.674371396968, 9308.0, 4983.053219888209, 4993.400791904995, 5001.374828146481, 5014.34813474246, 5015.423226329019, 4095.9590404096175, 4539.341795439643, 4652.488226295105, 4657.417822772153, 4671.6262698984, 3698.852045918133, 3757.9812100939866, 3782.6217378261954, 3816.0269131371324, 3952.3478626026385, 1132.3206076354122, 1133.7165708572857, 1133.960311389114, 1143.9942800285946, 1146.4439746722833, 1011.4285428732743, 1013.7820368620781, 1029.5933106422922, 1037.9481025948824, 1042.280826229899, 6199.721012554446, 6257.2491301044165, 6275.1842260506755, 6366.490680745622, 6433.131527243856, 427.3867000853785, 428.6378010581054, 430.4038906114991, 438.69729886378934, 439.1173740781053, 4228.0, 4327.805248763813, 4338.219120558329, 4371.366151907955, 4383.167198232326, 11033.0, 11460.426978651034, 11505.827412588818, 11519.942400288113, 11522.827157592643, 11132.833007504894, 11334.319940803578, 11355.37545435009, 11578.07375409982, 11610.535578576932, 8556.786080347916, 8567.785805354792, 8586.270167035747, 8669.956650216709, 8722.258608018263, 6197.225346831646, 6333.145025421509, 6335.176427064452, 6347.428731414195, 6388.1376014237485, 10160.593576257163, 10552.841707374242, 10600.0989915858, 10699.465026748787, 10706.8929310709, 10702.625408110678, 10783.460826958777, 10783.892161078602, 10792.244542881923, 10858.0, 6903.102596662402, 7250.854982900207, 7467.0, 7507.399408047234, 7520.172780994196, 8672.089430609947, 8707.042225355333, 8737.0, 8775.956120219358, 8792.648294068165, 8024.438289319692, 8034.236747508978, 8163.755087347389, 8236.96247028984, 8332.625031873458, 7894.171112033384, 7954.0, 7977.082635496992, 8078.23256790604, 8140.511569305861, 7024.227334993045, 7435.367993720594, 7485.214052524624, 7548.509346892434, 7580.583067931317, 5702.942970570241, 5707.68607726579, 5794.855128621818, 5807.186993820784, 5929.495992840484, 5709.229254050816, 5754.625949313281, 5774.220480235114, 5856.326522449973, 5898.911516327173], "value": 4556.887454800673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.2638110248788, 299.45798105429174, 313.1497982976219, 319.0381001281139, 320.5768385730835, 5619.4099619539975, 5623.915641265379, 5626.156076588513, 5634.5068556832475, 5656.208130861677, 5514.889702205954, 5525.530329921951, 5528.917066244009, 5532.502074813266, 5559.527440167591, 4098.344264917614, 4115.518413371184, 4170.728902621335, 4240.724352917051, 4247.617714405703, 4204.810783514749, 4229.259879521087, 4238.766867822269, 4250.447441832557, 4259.78701064947, 4217.43064686268, 4218.91562168758, 4231.809568569422, 4238.9152216955645, 4242.321228603424, 4003.2193722224033, 4189.868735441444, 4202.222588821078, 4205.894852628679, 4217.662586993033, 3634.1459756957092, 3658.762180458262, 3664.2121943782213, 3665.7433979621437, 3670.504481894963, 5307.389650190239, 5330.92003619946, 5342.759575819097, 5346.358436987547, 5360.597955153379, 4593.425821772278, 4777.761111944424, 4788.664793464459, 4817.181079216542, 4872.439669438025, 5707.686077265748, 5763.682997435139, 5776.249087618625, 5791.0, 5814.389489103625, 3955.0, 3955.7428767130045, 3965.8413663453425, 3983.3029219886403, 4001.8599349022643, 5947.0, 5955.583109182359, 5985.6408615483215, 6020.4280593344, 6028.668423236764, 4038.4548086008012, 4048.5344185418467, 4060.614241647039, 4064.146529228895, 4070.1452694933805, 4131.194417088699, 4141.875743727693, 4153.190127925026, 4154.854580089743, 4161.542230354658, 4708.835190768306, 4762.809487620457, 4800.4479484859685, 4812.133815913169, 4837.9032419351415, 5763.308402991668, 5786.04530252512, 5794.768209271582, 5818.5345172386105, 5822.214001109881, 1415.9858401415854, 1418.3688258724974, 1418.581518452059, 1419.6229657232468, 1438.1227451254726, 883.0463099852144, 897.6454300551246, 929.869818225449, 938.8921073133631, 967.9467629280457, 5407.324084489439, 5442.12925931849, 5457.617966742369, 5530.419305972895, 5537.640053396516, 5852.385499522489, 5855.414458554195, 5869.882602347929, 5904.380040095814, 5910.586258961917, 5414.675119492843, 5606.822567260921, 5646.898854723289, 5671.404502527258, 5681.77272909079, 3170.7304879085073, 3173.286010647632, 3208.197950512372, 3213.614366276062, 3223.854926528312, 5959.7914073008105, 6109.175261339751, 6155.72299246535, 6161.630302181883, 6200.0699895015205, 5976.0, 5986.413600395898, 6024.0662697282, 6032.245969253843, 6041.879162416815, 6136.509079273647, 6154.692265386713, 6161.229846269216, 6166.99999999991, 6168.9691551542855, 5653.604247702621, 5870.5010074142465, 5892.793752218652, 5930.584859059824, 5943.197668314722, 5716.9137863805745, 5798.275215598051, 5807.245058142415, 5823.970880145742, 5872.794452194153, 5990.460858522754, 6088.360722124113, 6094.75620975156, 6176.752929882934, 6197.4732147767945, 4017.5178978521594, 4036.535798383106, 4044.4337792709634, 4048.3320252158064, 4048.9797551012057, 5937.821865344046, 5953.422343079001, 5969.343372229138, 5982.910256346246, 6020.638761674313, 5528.226048353154, 5740.311162660508, 5745.482906538432, 5761.740721667619, 5802.361740208658, 5692.377672363356, 5711.400302968294, 5733.483986441241, 5776.480116789509, 5799.4780469757925, 5577.832665020056, 5629.240052592848, 5656.321241451053, 5763.608102637359, 5835.665733706552, 5895.734691938959, 5941.663125796661, 5950.315713692808, 5959.255093113361, 5978.701064946822, 5637.46444087811, 5800.680962546931, 5807.767689292381, 5811.360750317546, 5863.853403664943], "value": 4353.515982594146, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.7880332908453, 775.8409526047161, 820.7455688736492, 856.3149480415666, 874.986875196872, 14459.78310325346, 15204.619884502892, 15273.541793746177, 15305.311260993254, 15334.38662453502, 12959.222446653208, 13911.095778774372, 14289.785653215211, 14346.784798228035, 14429.42282308709, 786.3787607789839, 794.7854079398559, 803.3894240377297, 803.4135081390589, 803.9428151980128, 805.3677862877643, 807.8061265296345, 814.071957967917, 814.9934830484347, 816.3591580609223, 849.562475325208, 858.1675774498757, 859.6647307550061, 859.879616853641, 860.1269711243062, 849.2823564088335, 853.3130829682103, 855.3670283989865, 857.0829212742368, 857.618359829876, 625.0062400782732, 625.2809269340249, 625.3590070178104, 626.8307556959641, 627.0343670747044, 13285.202887826761, 13345.332733363293, 13357.198568085945, 13409.262490563015, 13416.93291533546, 12815.0, 12899.742005159938, 12954.157979731288, 13080.41138148776, 13387.0, 12406.255624662459, 12521.874781252161, 12572.182808117443, 12721.173123746927, 12791.424385902563, 4454.011507112055, 4459.977700111511, 4462.709923854939, 4468.0, 4541.114482675879, 58956.64173433057, 60303.09545356823, 60314.698426508025, 60505.69747151236, 60586.09120863191, 10440.530176142092, 10468.162546996222, 10496.842547361795, 10519.579216831242, 11179.608713695145, 19029.61940761205, 19118.42644720633, 19130.0, 19183.712244316346, 19259.133338999778, 8193.918060819435, 8256.1331060239, 8339.583020848933, 8381.622826972802, 8737.951445826542, 4656.8137274508645, 4680.625549955996, 4702.482726900038, 4740.004599034241, 4849.393825771778, 3160.2573395252098, 3212.6626704195724, 3214.694604012615, 3227.306129182237, 3237.4658181399805, 574.018428487283, 576.7404667899463, 581.988360232793, 587.4272584230426, 615.7444660465857, 721.3940290156189, 724.5037149552574, 764.0, 765.395337683224, 768.9507462612077, 10161.796764064677, 10407.929660750096, 10450.372977621368, 10518.316309439862, 10628.25602207838, 655.1646650520624, 721.8303698630817, 734.258399016986, 775.7207405334075, 779.980500487481, 4568.314752787109, 4807.206810876166, 4899.902001960012, 4915.09070821892, 4933.210686290176, 74134.0, 74195.0, 75760.62119689367, 75941.62029189819, 76032.61983690046, 63549.0, 65961.34038659552, 66118.33881661217, 66826.0, 66881.0, 54402.45597544053, 56388.0, 56841.0, 58245.41754582485, 59351.0, 9588.712338629852, 9625.181859541737, 9664.468454235084, 9850.359726617748, 10040.849387259052, 36213.818930905174, 36404.81797590995, 37623.0, 38116.0, 38132.80933595314, 50203.24695129649, 50298.49701502938, 50868.74565627148, 51189.74405127951, 52052.739736301075, 11559.364234967157, 11594.594189203337, 11663.24188927717, 12396.628101156979, 12773.23360598367, 14079.577612671636, 14138.717225655635, 14394.984702141499, 14402.567922962327, 14449.422023118957, 13581.86418135806, 13584.437789654316, 13613.931930340284, 13619.114757540729, 14176.149431034171, 12969.221846689228, 13253.933730331286, 13307.201567905957, 13320.800187996994, 13334.26661533625, 13058.542950996669, 13105.606831795061, 13148.211107333591, 13286.601401957956, 13401.396937138048, 10886.0, 10967.0, 10968.17738669587, 11000.614978475714, 11274.887251127384, 11007.0, 11037.337759734442, 11117.166212534254, 11232.719182020515, 11469.369184694922], "value": 7049.3427281159575, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 112.0, 112.0, 114.0, 110.0, 111.0, 110.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 166.0, 176.0, 129.0, 169.0, 152.0, 134.0, 186.0, 136.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 170.0, 162.0, 163.0, 163.0, 176.0, 162.0, 161.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 163.0, 76.0, 74.0, 74.0, 74.0, 168.0, 79.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 148.0, 83.0, 82.0, 83.0, 138.0, 83.0, 83.0, 138.0], "value": 100.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 57.0, 55.0, 58.0, 63.0, 54.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 64.0, 63.0, 64.0, 61.0, 63.0, 63.0, 63.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 79.0, 81.0, 80.0, 80.0, 83.0, 118.0, 80.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 124.0, 130.0, 121.0, 120.0, 134.0, 135.0, 137.0, 120.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 158.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 159.0, 158.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 65.0, 68.0, 62.0, 65.0, 62.0, 65.0, 62.0], "value": 63.9, "unit": "score"}]}]} 05:21:52 INFO - Return code: 0 05:21:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:21:52 ERROR - # TBPL SUCCESS # 05:21:52 INFO - Running post-action listener: _resource_record_post_action 05:21:52 INFO - ##### 05:21:52 INFO - ##### Finished run-tests step (success) 05:21:52 INFO - ##### 05:21:52 INFO - Running post-run listener: _resource_record_post_run 05:21:53 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540741632; Read time: 20; Write time: 516576 05:21:53 INFO - TinderboxPrint: CPU usage
13.4% 05:21:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:21:53 INFO - TinderboxPrint: I/O write bytes / time
540,741,632 / 516,576 05:21:53 INFO - TinderboxPrint: CPU idle
8,213.9 (86.6%) 05:21:53 INFO - TinderboxPrint: CPU user
1,219.5 (12.9%) 05:21:53 INFO - TinderboxPrint: Swap in / out
0 / 0 05:21:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247435264; Read time: 0; Write time: 255708 05:21:53 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293306368; Read time: 20; Write time: 260868 05:21:53 INFO - Running post-run listener: _upload_blobber_files 05:21:53 INFO - Blob upload gear active. 05:21:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:21:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:21:53 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'] 05:21:53 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 05:21:53 INFO - (blobuploader) - INFO - Open directory for files ... 05:21:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:21:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:21:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:54 INFO - (blobuploader) - INFO - Done attempting. 05:21:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:21:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:55 INFO - (blobuploader) - INFO - Done attempting. 05:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:00 INFO - (blobuploader) - INFO - Done attempting. 05:22:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:00 INFO - Return code: 0 05:22:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f67de58a1f4b756f0590ed10e710989e9e36d33aa73771d86e58130554d327bec8cf006f2969ac10b16dfb104a8a87fc8da83c1ed3e76f5ad33f48daeb55239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0c68308730280b22476340efbebd503d62be00d434e680b5ff0e79f0674db7373953627d20385b7b5987dbeb86a8e48303db94a3b25d4c5b276dbb26ce11fcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02328a2252b852a261021570e55ac224b241fd8ca2aa5b91848b05c947a11830bfbef0bf255f1543ee677622b3ed721dbe6fb948a3388edfb2c91fd3e203433b"} 05:22:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:00 INFO - Contents: 05:22:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f67de58a1f4b756f0590ed10e710989e9e36d33aa73771d86e58130554d327bec8cf006f2969ac10b16dfb104a8a87fc8da83c1ed3e76f5ad33f48daeb55239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0c68308730280b22476340efbebd503d62be00d434e680b5ff0e79f0674db7373953627d20385b7b5987dbeb86a8e48303db94a3b25d4c5b276dbb26ce11fcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02328a2252b852a261021570e55ac224b241fd8ca2aa5b91848b05c947a11830bfbef0bf255f1543ee677622b3ed721dbe6fb948a3388edfb2c91fd3e203433b"} 05:22:00 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:00 INFO - Copying logs to upload dir... 05:22:00 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.092596 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-28 05:21:59.966824) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 05:21:59.970102) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996 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/2f67de58a1f4b756f0590ed10e710989e9e36d33aa73771d86e58130554d327bec8cf006f2969ac10b16dfb104a8a87fc8da83c1ed3e76f5ad33f48daeb55239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0c68308730280b22476340efbebd503d62be00d434e680b5ff0e79f0674db7373953627d20385b7b5987dbeb86a8e48303db94a3b25d4c5b276dbb26ce11fcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02328a2252b852a261021570e55ac224b241fd8ca2aa5b91848b05c947a11830bfbef0bf255f1543ee677622b3ed721dbe6fb948a3388edfb2c91fd3e203433b"} build_url:https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/ZqK9gEKeQ-q8KklbMSvJNQ/artifacts/public/build/firefox-49.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/2f67de58a1f4b756f0590ed10e710989e9e36d33aa73771d86e58130554d327bec8cf006f2969ac10b16dfb104a8a87fc8da83c1ed3e76f5ad33f48daeb55239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0c68308730280b22476340efbebd503d62be00d434e680b5ff0e79f0674db7373953627d20385b7b5987dbeb86a8e48303db94a3b25d4c5b276dbb26ce11fcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02328a2252b852a261021570e55ac224b241fd8ca2aa5b91848b05c947a11830bfbef0bf255f1543ee677622b3ed721dbe6fb948a3388edfb2c91fd3e203433b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 05:21:59.995228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:21:59.995551) ========= 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=6d15e502d8e29d5d2676d664000001c3-1464435575.510748-949445996 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 05:22:00.077551) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 05:22:00.077871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 05:22:00.078163) ========= ========= Total master_lag: 0.18 =========