builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1463724557.73 results: success (0) buildid: 20160519193024 builduid: 6002e98b88be4c4f9a63ae13c6563ff3 revision: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:17.732163) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:17.733809) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:17.734145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:17.751152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:17.751477) ========= 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=ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 23:09:17-- 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.7M=0s 2016-05-19 23:09:17 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139918 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:17.908932) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:17.909691) ========= 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=ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019835 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:17.962352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 23:09:17.962745) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c67dc1f9fab86d4f2cf3224307809c44fe3ce820 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c67dc1f9fab86d4f2cf3224307809c44fe3ce820 --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=ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 23:09:18,013 truncating revision to first 12 chars 2016-05-19 23:09:18,013 Setting DEBUG logging. 2016-05-19 23:09:18,013 attempt 1/10 2016-05-19 23:09:18,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c67dc1f9fab8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 23:09:19,137 unpacking tar archive at: mozilla-central-c67dc1f9fab8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.409278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 23:09:19.386342) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:19.386822) ========= script_repo_revision: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:19.387330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:19.387742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 23:09:19.397145) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-19 23:09:19.397542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:19 INFO - MultiFileLogger online at 20160519 23:09:19 in /builds/slave/test 23:09:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 23:09:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:19 INFO - {'append_to_log': False, 23:09:19 INFO - 'base_work_dir': '/builds/slave/test', 23:09:19 INFO - 'blob_upload_branch': 'Firefox', 23:09:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:19 INFO - 'branch': 'Firefox', 23:09:19 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:19 INFO - 'config_files': ('talos/linux_config.py',), 23:09:19 INFO - 'default_actions': ('clobber', 23:09:19 INFO - 'read-buildbot-config', 23:09:19 INFO - 'download-and-extract', 23:09:19 INFO - 'populate-webroot', 23:09:19 INFO - 'create-virtualenv', 23:09:19 INFO - 'install', 23:09:19 INFO - 'run-tests'), 23:09:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:19 INFO - 'download_minidump_stackwalk': True, 23:09:19 INFO - 'download_symbols': 'ondemand', 23:09:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:19 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:19 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:19 INFO - 'installer_path': 'installer.exe', 23:09:19 INFO - 'log_level': 'info', 23:09:19 INFO - 'log_name': 'talos', 23:09:19 INFO - 'log_to_console': True, 23:09:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:19 INFO - 'opt_config_files': (), 23:09:19 INFO - 'pip_index': False, 23:09:19 INFO - 'sps_profile': False, 23:09:19 INFO - 'sps_profile_interval': 0, 23:09:19 INFO - 'suite': 'dromaeojs-e10s', 23:09:19 INFO - 'system_bits': '32', 23:09:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:19 INFO - 'title': 'talos-linux64-ix-024', 23:09:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:19 INFO - 'use_talos_json': True, 23:09:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:19 INFO - 'work_dir': 'build'} 23:09:19 INFO - ##### 23:09:19 INFO - ##### Running clobber step. 23:09:19 INFO - ##### 23:09:19 INFO - Running pre-action listener: _resource_record_pre_action 23:09:19 INFO - Running main action method: clobber 23:09:19 INFO - rmtree: /builds/slave/test/build 23:09:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:20 INFO - Running post-action listener: _resource_record_post_action 23:09:20 INFO - ##### 23:09:20 INFO - ##### Finished clobber step (success) 23:09:20 INFO - ##### 23:09:20 INFO - ##### 23:09:20 INFO - ##### Running read-buildbot-config step. 23:09:20 INFO - ##### 23:09:20 INFO - Running pre-action listener: _resource_record_pre_action 23:09:20 INFO - Running main action method: read_buildbot_config 23:09:20 INFO - Using buildbot properties: 23:09:20 INFO - { 23:09:20 INFO - "project": "", 23:09:20 INFO - "product": "firefox", 23:09:20 INFO - "script_repo_revision": "production", 23:09:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:09:20 INFO - "repository": "", 23:09:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 23:09:20 INFO - "buildid": "20160519193024", 23:09:20 INFO - "pgo_build": "True", 23:09:20 INFO - "basedir": "/builds/slave/test", 23:09:20 INFO - "buildnumber": 211, 23:09:20 INFO - "slavename": "talos-linux64-ix-024", 23:09:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:09:20 INFO - "platform": "ubuntu64_hw", 23:09:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 23:09:20 INFO - "branch": "mozilla-central", 23:09:20 INFO - "repo_path": "mozilla-central", 23:09:20 INFO - "revision": "c67dc1f9fab86d4f2cf3224307809c44fe3ce820", 23:09:20 INFO - "stage_platform": "linux64-pgo", 23:09:20 INFO - "builduid": "6002e98b88be4c4f9a63ae13c6563ff3", 23:09:20 INFO - "slavebuilddir": "test" 23:09:20 INFO - } 23:09:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:09:20 INFO - Running post-action listener: _resource_record_post_action 23:09:20 INFO - ##### 23:09:20 INFO - ##### Finished read-buildbot-config step (success) 23:09:20 INFO - ##### 23:09:20 INFO - ##### 23:09:20 INFO - ##### Running download-and-extract step. 23:09:20 INFO - ##### 23:09:20 INFO - Running pre-action listener: _resource_record_pre_action 23:09:20 INFO - Running main action method: download_and_extract 23:09:20 INFO - mkdir: /builds/slave/test/build/tests 23:09: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')]} 23:09:20 INFO - https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:22 INFO - Downloaded 1361 bytes. 23:09:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:22 INFO - Using the following test package requirements: 23:09:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:22 INFO - u'jsshell-linux-x86_64.zip'], 23:09:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:22 INFO - https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:26 INFO - Downloaded 24388081 bytes. 23:09:26 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'] 23:09:26 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 23:09:28 INFO - Return code: 0 23:09:28 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 23:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:28 INFO - https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:30 INFO - Downloaded 24388081 bytes. 23:09:30 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'] 23:09:30 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 23:09:32 INFO - Return code: 0 23:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:32 INFO - https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:33 INFO - Downloaded 10840359 bytes. 23:09:33 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'] 23:09:33 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 23:09:33 INFO - Return code: 0 23:09:33 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')]} 23:09:33 INFO - https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9mwayojRmKMHwSm_8yByg/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 23:09:34 INFO - Downloaded 58608180 bytes. 23:09:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:34 INFO - mkdir: /builds/slave/test/properties 23:09:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:34 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:34 INFO - Contents: 23:09:34 INFO - build_url:https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:35 INFO - Running post-action listener: _resource_record_post_action 23:09:35 INFO - Running post-action listener: set_extra_try_arguments 23:09:35 INFO - ##### 23:09:35 INFO - ##### Finished download-and-extract step (success) 23:09:35 INFO - ##### 23:09:35 INFO - ##### 23:09:35 INFO - ##### Running populate-webroot step. 23:09:35 INFO - ##### 23:09:35 INFO - Running pre-action listener: _resource_record_pre_action 23:09:35 INFO - Running main action method: populate_webroot 23:09:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:35 INFO - '--tppagecycles', 23:09:35 INFO - '7'], 23:09:35 INFO - 'tests': ['tsvgm']}}, 23:09:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['damp', 'tps']}, 23:09:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'tests': ['damp', 'tps']}, 23:09:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['dromaeo_dom']}, 23:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['a11yr', 23:09:35 INFO - 'ts_paint', 23:09:35 INFO - 'tpaint', 23:09:35 INFO - 'sessionrestore', 23:09:35 INFO - 'sessionrestore_no_auto_restore', 23:09:35 INFO - 'tabpaint']}, 23:09:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['tsvgx', 23:09:35 INFO - 'tsvgr_opacity', 23:09:35 INFO - 'tart', 23:09:35 INFO - 'tscrollx', 23:09:35 INFO - 'cart']}, 23:09:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:35 INFO - 'tsvgr_opacity', 23:09:35 INFO - 'tart', 23:09:35 INFO - 'tscrollx', 23:09:35 INFO - 'cart']}, 23:09:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--disable-e10s'], 23:09:35 INFO - 'tests': ['tp5o']}, 23:09:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'tests': ['tp5o']}, 23:09:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--disable-e10s', 23:09:35 INFO - '--xperf_path', 23:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:35 INFO - 'tests': ['tp5n']}, 23:09:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:35 INFO - 'talos_options': ['--xperf_path', 23:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:35 INFO - 'tests': ['tp5n']}}, 23:09:35 INFO - 'talos.zip': {'path': '', 23:09:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:35 INFO - Running post-action listener: _resource_record_post_action 23:09:35 INFO - ##### 23:09:35 INFO - ##### Finished populate-webroot step (success) 23:09:35 INFO - ##### 23:09:35 INFO - ##### 23:09:35 INFO - ##### Running create-virtualenv step. 23:09:35 INFO - ##### 23:09:35 INFO - Running pre-action listener: _resource_record_pre_action 23:09:35 INFO - Running main action method: create_virtualenv 23:09:35 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:35 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 23:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:35 INFO - Using real prefix '/usr' 23:09:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:38 INFO - Installing pip.................done. 23:09:38 INFO - Return code: 0 23:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:09:38 INFO - Using env: {'DISPLAY': ':0', 23:09:38 INFO - 'HOME': '/home/cltbld', 23:09:38 INFO - 'LANG': 'en_US.UTF-8', 23:09:38 INFO - 'LANGUAGE': 'en_US:en', 23:09:38 INFO - 'LOGNAME': 'cltbld', 23:09:38 INFO - 'MAIL': '/var/mail/cltbld', 23:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:38 INFO - 'MOZ_NO_REMOTE': '1', 23:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:38 INFO - 'NO_EM_RESTART': '1', 23:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:38 INFO - 'PWD': '/builds/slave/test', 23:09:38 INFO - 'SHELL': '/bin/bash', 23:09:38 INFO - 'SHLVL': '1', 23:09:38 INFO - 'TERM': 'linux', 23:09:38 INFO - 'TMOUT': '86400', 23:09:38 INFO - 'USER': 'cltbld', 23:09:38 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:38 INFO - '_': '/tools/buildbot/bin/python'} 23:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:38 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 23:09:38 INFO - Cleaning up... 23:09:38 INFO - Return code: 0 23:09:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:09:38 INFO - Using env: {'DISPLAY': ':0', 23:09:38 INFO - 'HOME': '/home/cltbld', 23:09:38 INFO - 'LANG': 'en_US.UTF-8', 23:09:38 INFO - 'LANGUAGE': 'en_US:en', 23:09:38 INFO - 'LOGNAME': 'cltbld', 23:09:38 INFO - 'MAIL': '/var/mail/cltbld', 23:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:38 INFO - 'MOZ_NO_REMOTE': '1', 23:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:38 INFO - 'NO_EM_RESTART': '1', 23:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:38 INFO - 'PWD': '/builds/slave/test', 23:09:38 INFO - 'SHELL': '/bin/bash', 23:09:38 INFO - 'SHLVL': '1', 23:09:38 INFO - 'TERM': 'linux', 23:09:38 INFO - 'TMOUT': '86400', 23:09:38 INFO - 'USER': 'cltbld', 23:09:38 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:38 INFO - '_': '/tools/buildbot/bin/python'} 23:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:38 INFO - Downloading/unpacking psutil>=3.1.1 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:40 INFO - Installing collected packages: psutil 23:09:40 INFO - Running setup.py install for psutil 23:09:40 INFO - building 'psutil._psutil_linux' extension 23:09:40 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 23:09:40 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 23:09:41 INFO - building 'psutil._psutil_posix' extension 23:09:41 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 23:09:41 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 23:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:41 INFO - Successfully installed psutil 23:09:41 INFO - Cleaning up... 23:09:41 INFO - Return code: 0 23:09:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:09: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 mozsystemmonitor==0.3 23:09:41 INFO - Using env: {'DISPLAY': ':0', 23:09:41 INFO - 'HOME': '/home/cltbld', 23:09:41 INFO - 'LANG': 'en_US.UTF-8', 23:09:41 INFO - 'LANGUAGE': 'en_US:en', 23:09:41 INFO - 'LOGNAME': 'cltbld', 23:09:41 INFO - 'MAIL': '/var/mail/cltbld', 23:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:41 INFO - 'MOZ_NO_REMOTE': '1', 23:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:41 INFO - 'NO_EM_RESTART': '1', 23:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:41 INFO - 'PWD': '/builds/slave/test', 23:09:41 INFO - 'SHELL': '/bin/bash', 23:09:41 INFO - 'SHLVL': '1', 23:09:41 INFO - 'TERM': 'linux', 23:09:41 INFO - 'TMOUT': '86400', 23:09:41 INFO - 'USER': 'cltbld', 23:09:41 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:41 INFO - '_': '/tools/buildbot/bin/python'} 23:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:09:43 INFO - Installing collected packages: mozsystemmonitor 23:09:43 INFO - Running setup.py install for mozsystemmonitor 23:09:43 INFO - Successfully installed mozsystemmonitor 23:09:43 INFO - Cleaning up... 23:09:44 INFO - Return code: 0 23:09:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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', '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 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:09: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 blobuploader==1.2.4 23:09:44 INFO - Using env: {'DISPLAY': ':0', 23:09:44 INFO - 'HOME': '/home/cltbld', 23:09:44 INFO - 'LANG': 'en_US.UTF-8', 23:09:44 INFO - 'LANGUAGE': 'en_US:en', 23:09:44 INFO - 'LOGNAME': 'cltbld', 23:09:44 INFO - 'MAIL': '/var/mail/cltbld', 23:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:44 INFO - 'MOZ_NO_REMOTE': '1', 23:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:44 INFO - 'NO_EM_RESTART': '1', 23:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:44 INFO - 'PWD': '/builds/slave/test', 23:09:44 INFO - 'SHELL': '/bin/bash', 23:09:44 INFO - 'SHLVL': '1', 23:09:44 INFO - 'TERM': 'linux', 23:09:44 INFO - 'TMOUT': '86400', 23:09:44 INFO - 'USER': 'cltbld', 23:09:44 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:44 INFO - '_': '/tools/buildbot/bin/python'} 23:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:44 INFO - Downloading/unpacking blobuploader==1.2.4 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:46 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:46 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 23:09:46 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 23:09:46 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 23:09:46 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 23:09:46 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 23:09:46 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 23:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:46 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 23:09:46 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 23:09:46 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 23:09:46 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 23:09:46 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 23:09:46 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 23:09:47 INFO - Downloading docopt-0.6.1.tar.gz 23:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:47 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:47 INFO - Running setup.py install for blobuploader 23:09:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:47 INFO - Running setup.py install for requests 23:09:47 INFO - Running setup.py install for docopt 23:09:47 INFO - Successfully installed blobuploader requests docopt 23:09:47 INFO - Cleaning up... 23:09:47 INFO - Return code: 0 23:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 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 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09:47 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 23:09:47 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 23:09:47 INFO - Using env: {'DISPLAY': ':0', 23:09:47 INFO - 'HOME': '/home/cltbld', 23:09:47 INFO - 'LANG': 'en_US.UTF-8', 23:09:47 INFO - 'LANGUAGE': 'en_US:en', 23:09:47 INFO - 'LOGNAME': 'cltbld', 23:09:47 INFO - 'MAIL': '/var/mail/cltbld', 23:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:47 INFO - 'MOZ_NO_REMOTE': '1', 23:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:47 INFO - 'NO_EM_RESTART': '1', 23:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:47 INFO - 'PWD': '/builds/slave/test', 23:09:47 INFO - 'SHELL': '/bin/bash', 23:09:47 INFO - 'SHLVL': '1', 23:09:47 INFO - 'TERM': 'linux', 23:09:47 INFO - 'TMOUT': '86400', 23:09:47 INFO - 'USER': 'cltbld', 23:09:47 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:47 INFO - '_': '/tools/buildbot/bin/python'} 23:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:47 INFO - Running setup.py (path:/tmp/pip-gVz9FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:48 INFO - Running setup.py (path:/tmp/pip-BOLfQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:48 INFO - Running setup.py (path:/tmp/pip-oVyXPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:48 INFO - Running setup.py (path:/tmp/pip-U2ctiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:48 INFO - Running setup.py (path:/tmp/pip-6qy6OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:48 INFO - Running setup.py (path:/tmp/pip-SpI57G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:48 INFO - Running setup.py (path:/tmp/pip-mYW2Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:48 INFO - Running setup.py (path:/tmp/pip-lVmRV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:48 INFO - Running setup.py (path:/tmp/pip-fstrDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:48 INFO - Running setup.py (path:/tmp/pip-bBKnVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:48 INFO - Running setup.py (path:/tmp/pip-mPS4yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:48 INFO - Running setup.py (path:/tmp/pip-qDTXh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:48 INFO - Running setup.py (path:/tmp/pip-FscEMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:48 INFO - Running setup.py (path:/tmp/pip-IvuY3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:48 INFO - Running setup.py (path:/tmp/pip-UgRC1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:49 INFO - Running setup.py (path:/tmp/pip-8WZLZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:49 INFO - Running setup.py (path:/tmp/pip-OC1FaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:49 INFO - Running setup.py install for manifestparser 23:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for mozcrash 23:09:49 INFO - Running setup.py install for mozdebug 23:09:49 INFO - Running setup.py install for mozdevice 23:09:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for mozfile 23:09:49 INFO - Running setup.py install for mozhttpd 23:09:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for mozinfo 23:09:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for mozInstall 23:09:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:49 INFO - Running setup.py install for mozleak 23:09:50 INFO - Running setup.py install for mozlog 23:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:50 INFO - Running setup.py install for moznetwork 23:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:50 INFO - Running setup.py install for mozprocess 23:09:50 INFO - Running setup.py install for mozprofile 23:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:50 INFO - Running setup.py install for mozrunner 23:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:50 INFO - Running setup.py install for mozscreenshot 23:09:50 INFO - Running setup.py install for moztest 23:09:50 INFO - Running setup.py install for mozversion 23:09:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:50 INFO - Cleaning up... 23:09:50 INFO - Return code: 0 23:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:50 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 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09:50 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 23:09:50 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 23:09:50 INFO - Using env: {'DISPLAY': ':0', 23:09:50 INFO - 'HOME': '/home/cltbld', 23:09:50 INFO - 'LANG': 'en_US.UTF-8', 23:09:50 INFO - 'LANGUAGE': 'en_US:en', 23:09:50 INFO - 'LOGNAME': 'cltbld', 23:09:50 INFO - 'MAIL': '/var/mail/cltbld', 23:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:50 INFO - 'MOZ_NO_REMOTE': '1', 23:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:50 INFO - 'NO_EM_RESTART': '1', 23:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:50 INFO - 'PWD': '/builds/slave/test', 23:09:50 INFO - 'SHELL': '/bin/bash', 23:09:50 INFO - 'SHLVL': '1', 23:09:50 INFO - 'TERM': 'linux', 23:09:50 INFO - 'TMOUT': '86400', 23:09:50 INFO - 'USER': 'cltbld', 23:09:50 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:50 INFO - '_': '/tools/buildbot/bin/python'} 23:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:51 INFO - Running setup.py (path:/tmp/pip-7JkzxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:51 INFO - Running setup.py (path:/tmp/pip-BniXC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:51 INFO - Running setup.py (path:/tmp/pip-NFjQVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:51 INFO - Running setup.py (path:/tmp/pip-_TyX9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:51 INFO - Running setup.py (path:/tmp/pip-9aorVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:51 INFO - Running setup.py (path:/tmp/pip-2jdKxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:51 INFO - Running setup.py (path:/tmp/pip-v37qgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:51 INFO - Running setup.py (path:/tmp/pip-HAnJPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:51 INFO - Running setup.py (path:/tmp/pip-RJ7g_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:51 INFO - Running setup.py (path:/tmp/pip-BEDKUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:51 INFO - Running setup.py (path:/tmp/pip-YMTF04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:51 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)) 23:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:52 INFO - Running setup.py (path:/tmp/pip-2epXIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:52 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)) 23:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:52 INFO - Running setup.py (path:/tmp/pip-cRgbdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:52 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)) 23:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:52 INFO - Running setup.py (path:/tmp/pip-t4AK3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:52 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)) 23:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:52 INFO - Running setup.py (path:/tmp/pip-XhQT3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:52 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)) 23:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:52 INFO - Running setup.py (path:/tmp/pip-lxW5M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:52 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)) 23:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:52 INFO - Running setup.py (path:/tmp/pip-eDcPF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:52 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)) 23:09:52 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)) 23:09:52 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)) 23:09:52 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)) 23:09:52 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)) 23:09:52 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)) 23:09:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:52 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 23:09:52 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 23:09:52 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 23:09:52 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 23:09:52 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 23:09:52 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 23:09:54 INFO - Downloading blessings-1.6.tar.gz 23:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:09:54 INFO - Installing collected packages: blessings 23:09:54 INFO - Running setup.py install for blessings 23:09:54 INFO - Successfully installed blessings 23:09:54 INFO - Cleaning up... 23:09:54 INFO - Return code: 0 23:09:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:54 INFO - Reading from file tmpfile_stdout 23:09:54 INFO - Current package versions: 23:09:54 INFO - argparse == 1.2.1 23:09:54 INFO - blessings == 1.6 23:09:54 INFO - blobuploader == 1.2.4 23:09:54 INFO - docopt == 0.6.1 23:09:54 INFO - manifestparser == 1.1 23:09:54 INFO - mozInstall == 1.12 23:09:54 INFO - mozcrash == 0.17 23:09:54 INFO - mozdebug == 0.1 23:09:54 INFO - mozdevice == 0.48 23:09:54 INFO - mozfile == 1.2 23:09:54 INFO - mozhttpd == 0.7 23:09:54 INFO - mozinfo == 0.9 23:09:54 INFO - mozleak == 0.1 23:09:54 INFO - mozlog == 3.2 23:09:54 INFO - moznetwork == 0.27 23:09:54 INFO - mozprocess == 0.22 23:09:54 INFO - mozprofile == 0.28 23:09:54 INFO - mozrunner == 6.11 23:09:54 INFO - mozscreenshot == 0.1 23:09:54 INFO - mozsystemmonitor == 0.3 23:09:54 INFO - moztest == 0.7 23:09:54 INFO - mozversion == 1.4 23:09:54 INFO - psutil == 3.1.1 23:09:54 INFO - requests == 1.2.3 23:09:54 INFO - wsgiref == 0.1.2 23:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:54 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')]} 23:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:54 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')]} 23:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:54 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 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09:54 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 23:09:54 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 23:09:54 INFO - Using env: {'DISPLAY': ':0', 23:09:54 INFO - 'HOME': '/home/cltbld', 23:09:54 INFO - 'LANG': 'en_US.UTF-8', 23:09:54 INFO - 'LANGUAGE': 'en_US:en', 23:09:54 INFO - 'LOGNAME': 'cltbld', 23:09:54 INFO - 'MAIL': '/var/mail/cltbld', 23:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:54 INFO - 'MOZ_NO_REMOTE': '1', 23:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:54 INFO - 'NO_EM_RESTART': '1', 23:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:54 INFO - 'PWD': '/builds/slave/test', 23:09:54 INFO - 'SHELL': '/bin/bash', 23:09:54 INFO - 'SHLVL': '1', 23:09:54 INFO - 'TERM': 'linux', 23:09:54 INFO - 'TMOUT': '86400', 23:09:54 INFO - 'USER': 'cltbld', 23:09:54 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:54 INFO - '_': '/tools/buildbot/bin/python'} 23:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 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)) 23:09:54 INFO - Cleaning up... 23:09:54 INFO - Return code: 0 23:09:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:09:54 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')]} 23:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:54 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')]} 23:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:54 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 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09:54 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 23:09:54 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 23:09:54 INFO - Using env: {'DISPLAY': ':0', 23:09:54 INFO - 'HOME': '/home/cltbld', 23:09:54 INFO - 'LANG': 'en_US.UTF-8', 23:09:54 INFO - 'LANGUAGE': 'en_US:en', 23:09:54 INFO - 'LOGNAME': 'cltbld', 23:09:54 INFO - 'MAIL': '/var/mail/cltbld', 23:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:54 INFO - 'MOZ_NO_REMOTE': '1', 23:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:54 INFO - 'NO_EM_RESTART': '1', 23:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:54 INFO - 'PWD': '/builds/slave/test', 23:09:54 INFO - 'SHELL': '/bin/bash', 23:09:54 INFO - 'SHLVL': '1', 23:09:54 INFO - 'TERM': 'linux', 23:09:54 INFO - 'TMOUT': '86400', 23:09:54 INFO - 'USER': 'cltbld', 23:09:54 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:54 INFO - '_': '/tools/buildbot/bin/python'} 23:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:55 INFO - Downloading/unpacking jsonschema 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:09:57 INFO - Downloading/unpacking functools32 (from jsonschema) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:57 INFO - Downloading functools32-3.2.3-2.tar.gz 23:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:09:57 INFO - warning: no files found matching '*.txt' 23:09:57 INFO - no previously-included directories found matching 'build' 23:09:57 INFO - no previously-included directories found matching 'dist' 23:09:57 INFO - no previously-included directories found matching '.git*' 23:09:57 INFO - Installing collected packages: jsonschema, functools32 23:09:57 INFO - Running setup.py install for functools32 23:09:57 INFO - warning: no files found matching '*.txt' 23:09:57 INFO - no previously-included directories found matching 'build' 23:09:57 INFO - no previously-included directories found matching 'dist' 23:09:57 INFO - no previously-included directories found matching '.git*' 23:09:57 INFO - Successfully installed jsonschema functools32 23:09:57 INFO - Cleaning up... 23:09:57 INFO - Return code: 0 23:09:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd09fd0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a33770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, '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': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', '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 23:09: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', 'flake8'] in /builds/slave/test/build 23:09: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 flake8 23:09:57 INFO - Using env: {'DISPLAY': ':0', 23:09:57 INFO - 'HOME': '/home/cltbld', 23:09:57 INFO - 'LANG': 'en_US.UTF-8', 23:09:57 INFO - 'LANGUAGE': 'en_US:en', 23:09:57 INFO - 'LOGNAME': 'cltbld', 23:09:57 INFO - 'MAIL': '/var/mail/cltbld', 23:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:57 INFO - 'MOZ_NO_REMOTE': '1', 23:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:57 INFO - 'NO_EM_RESTART': '1', 23:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:57 INFO - 'PWD': '/builds/slave/test', 23:09:57 INFO - 'SHELL': '/bin/bash', 23:09:57 INFO - 'SHLVL': '1', 23:09:57 INFO - 'TERM': 'linux', 23:09:57 INFO - 'TMOUT': '86400', 23:09:57 INFO - 'USER': 'cltbld', 23:09:57 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:57 INFO - '_': '/tools/buildbot/bin/python'} 23:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:57 INFO - Downloading/unpacking flake8 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:09:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:09:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:10:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:00 INFO - no previously-included directories found matching 'docs/_build' 23:10:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:10:00 INFO - Running setup.py install for pep8 23:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:00 INFO - no previously-included directories found matching 'docs/_build' 23:10:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:10:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:10:00 INFO - Cleaning up... 23:10:00 INFO - Return code: 0 23:10:00 INFO - Running post-action listener: _resource_record_post_action 23:10:00 INFO - Running post-action listener: _start_resource_monitoring 23:10:00 INFO - Starting resource monitoring. 23:10:00 INFO - ##### 23:10:00 INFO - ##### Finished create-virtualenv step (success) 23:10:00 INFO - ##### 23:10:00 INFO - ##### 23:10:00 INFO - ##### Running install step. 23:10:00 INFO - ##### 23:10:00 INFO - Running pre-action listener: _resource_record_pre_action 23:10:00 INFO - Running main action method: install 23:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:00 INFO - Reading from file tmpfile_stdout 23:10:00 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:10:00 INFO - Reading from file tmpfile_stdout 23:10:00 INFO - Output received: 23:10:00 INFO - Usage: mozinstall [options] installer 23:10:00 INFO - Options: 23:10:00 INFO - -h, --help show this help message and exit 23:10:00 INFO - -d DEST, --destination=DEST 23:10:00 INFO - Directory to install application into. [default: 23:10:00 INFO - "/builds/slave/test"] 23:10:00 INFO - --app=APP Application being installed. [default: firefox] 23:10:00 INFO - mkdir: /builds/slave/test/build/application 23:10:00 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'] 23:10:00 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 23:10:17 INFO - Reading from file tmpfile_stdout 23:10:17 INFO - Output received: 23:10:17 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:17 INFO - Running post-action listener: _resource_record_post_action 23:10:17 INFO - ##### 23:10:17 INFO - ##### Finished install step (success) 23:10:17 INFO - ##### 23:10:17 INFO - ##### 23:10:17 INFO - ##### Running run-tests step. 23:10:17 INFO - ##### 23:10:17 INFO - Running pre-action listener: _resource_record_pre_action 23:10:17 INFO - Running main action method: run_tests 23:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:17 INFO - Python 2.7.3 23:10:17 INFO - Return code: 0 23:10:17 INFO - grabbing minidump binary from tooltool 23:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:17 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 0x2ac29c0>, '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 0x2ac38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:17 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 23:10:17 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 23:10:17 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 23:10:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:17 INFO - Return code: 0 23:10:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:10:18 INFO - Return code: 0 23:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 23:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 23:10:18 INFO - Using env: {'DISPLAY': ':0', 23:10:18 INFO - 'HOME': '/home/cltbld', 23:10:18 INFO - 'LANG': 'en_US.UTF-8', 23:10:18 INFO - 'LANGUAGE': 'en_US:en', 23:10:18 INFO - 'LOGNAME': 'cltbld', 23:10:18 INFO - 'MAIL': '/var/mail/cltbld', 23:10:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:18 INFO - 'MOZ_NO_REMOTE': '1', 23:10:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:18 INFO - 'NO_EM_RESTART': '1', 23:10:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:18 INFO - 'PWD': '/builds/slave/test', 23:10:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:18 INFO - 'SHELL': '/bin/bash', 23:10:18 INFO - 'SHLVL': '1', 23:10:18 INFO - 'TERM': 'linux', 23:10:18 INFO - 'TMOUT': '86400', 23:10:18 INFO - 'USER': 'cltbld', 23:10:18 INFO - 'XDG_SESSION_COOKIE': 'ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002', 23:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:18 INFO - '_': '/tools/buildbot/bin/python'} 23:10:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 23:10:18 INFO - mozversion application_buildid: 20160519193024 23:10:18 INFO - mozversion application_changeset: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 23:10:18 INFO - mozversion application_display_name: Nightly 23:10:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:18 INFO - mozversion application_name: Firefox 23:10:18 INFO - mozversion application_remotingname: firefox 23:10:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:10:18 INFO - mozversion application_vendor: Mozilla 23:10:18 INFO - mozversion application_version: 49.0a1 23:10:18 INFO - mozversion platform_buildid: 20160519193024 23:10:18 INFO - mozversion platform_changeset: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 23:10:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:10:18 INFO - mozversion platform_version: 49.0a1 23:10:18 INFO - using testdate: 1463724618 23:10:18 INFO - actual date: 1463724618 23:10:18 INFO - starting webserver on 'localhost:37787' 23:10:18 INFO - SUITE-START | Running 2 tests 23:10:18 INFO - TEST-START | dromaeo_css 23:10:18 INFO - operating with platform_type : linux_ 23:10:18 INFO - Initialising browser for dromaeo_css test... 23:10:18 INFO - TEST-INFO | started process 23340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1Fg0h/profile http://localhost:37787/getInfo.html) 23:10:22 INFO - PROCESS | 23340 | 23:10:22 INFO - PROCESS | 23340 | (process:23410): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:23 INFO - PROCESS | 23340 | __metrics Screen width/height:1600/1200 23:10:23 INFO - PROCESS | 23340 | colorDepth:24 23:10:23 INFO - PROCESS | 23340 | Browser inner width/height: 1024/697 23:10:23 INFO - PROCESS | 23340 | __metrics 23:10:24 ERROR - PROCESS | 23340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:10:25 INFO - TEST-INFO | 23340: exit 0 23:10:25 INFO - Browser initialized. 23:10:25 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:25 INFO - TEST-INFO | started process 23461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq1Fg0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:26 INFO - PROCESS | 23461 | 23:10:26 INFO - PROCESS | 23461 | (process:23522): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:36 INFO - PROCESS | 23461 | RSS: Main: 163962880 23:10:36 INFO - PROCESS | 23461 | 23:11:26 INFO - PROCESS | 23461 | 1463724686556 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] 23:13:34 INFO - PROCESS | 23461 | Cycle 1(1): loaded http://localhost:37787/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37787/tests/dromaeo/cssquery-ext.html) 23:13:36 INFO - PROCESS | 23461 | RSS: Main: 167321600 23:13:36 INFO - PROCESS | 23461 | 23:16:38 INFO - PROCESS | 23461 | Cycle 1(1): loaded http://localhost:37787/tests/dromaeo/cssquery-ext.html (next: http://localhost:37787/tests/dromaeo/cssquery-jquery.html) 23:16:39 INFO - PROCESS | 23461 | RSS: Main: 167002112 23:16:39 INFO - PROCESS | 23461 | 23:19:40 INFO - PROCESS | 23461 | Cycle 1(1): loaded http://localhost:37787/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37787/tests/dromaeo/cssquery-mootools.html) 23:19:41 INFO - PROCESS | 23461 | RSS: Main: 168087552 23:19:41 INFO - PROCESS | 23461 | 23:22:43 INFO - PROCESS | 23461 | Cycle 1(1): loaded http://localhost:37787/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37787/tests/dromaeo/cssquery-prototype.html) 23:22:43 INFO - PROCESS | 23461 | RSS: Main: 165851136 23:22:43 INFO - PROCESS | 23461 | 23:25:46 INFO - PROCESS | 23461 | Cycle 1(1): loaded http://localhost:37787/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37787/tests/dromaeo/cssquery-yui.html) 23:25:46 INFO - PROCESS | 23461 | RSS: Main: 166985728 23:25:46 INFO - PROCESS | 23461 | 23:28:49 INFO - PROCESS | 23461 | Cycle 1(1): loaded http://localhost:37787/tests/dromaeo/cssquery-yui.html (next: http://localhost:37787/tests/dromaeo/cssquery-dojo.html) 23:28:50 INFO - PROCESS | 23461 | RSS: Main: 169353216 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | __start_tp_report 23:28:50 INFO - PROCESS | 23461 | _x_x_mozilla_page_load 23:28:50 INFO - PROCESS | 23461 | _x_x_mozilla_page_load_details 23:28:50 INFO - PROCESS | 23461 | |i|pagename|runs| 23:28:50 INFO - PROCESS | 23461 | |0;dojo.html;3161.336119414923;3168.097092328687;3195.9840200799;3206.470932296171;3213.0200288911888;5312.999999999995;5313.495217954293;5329.147336426173;5420.864478388043;5442.83671489855;5315.920261196085;5448.591355648332;5462.180672899067;5495.587830912677;5513.145462453326;4931.531504507075;4956.058348913695;5015.272785446108;5092.974535127338;5147.897042059157;4922.630802689795;5108.824970256843;5173.327467429229;5173.844784656466;5188.7146206958605;4911.484294149099;4948.851534453954;4999.475055119215;5016.974915125401;5025.020121076392;5007.273945277951;5021.69869807809;5032.924506132411;5034.043531728959;5084.44071152173;5005.199168133117;5006.474320196364;5012.0727665381655;5028.421731500887;5031.974840125813;5224.686518808883;5302.681839089667;5314.73426328682;5339.466053394668;5361.785528578852;5819.214406055171;5842.766289348421;5852.326982397036;5859.1504231886565;5868.178455016301;5718.228039214694;5881.647101173943;5894.793682221145;5906.616069955439;5928.881422371572;5424.891502169935;5465.043617366945;5483.945160548384;5485.6982865942355;5498.725063746797;5898;5997.100434934795;5997.280326360865;5998.880022399528;6017.759289628453;5561.277033985637;5669.489745922887;5770.798022069207;5783;5787.1319302104175;5748.965186266512;5813.476787089182;5825.970870145622;5847.532197424196;5874.030784920526;5597.244372009808;5699.088145896637;5804.535637149018;5811.506021988093;5827.504662103769;5875.11873219012;5882.294124705063;5888.440598143169;5889.234399528034;5903.203067585907;4321.330193819963;4374.934375984363;4396.736195828261;4423.955760442419;4466.865994020184;3968.7618742874943;3974.364101743707;3980.960190398059;4007.038310805444;4007.959920400817;5399.70301633414;5672.943270567242;5681.375048744718;5707.286589176353;5717.085266357363;5834.795782147605;5882.558808089325;5890.969080410911;5901.17383566301;5921.526277897758;5625.353084395347;5630.5495560355075;5639.182318563785;5649.6327738696855;5651.6043876928225;4874.268859671078;5020.924686129711;5024.547790698854;5031.77357018935;5082.313887625197;6056.454919057306;6103.337669688931;6121.950611746565;6128.380904898417;6129.392748099212;5933.080372542263;5934.999999999914;5944.227250457413;5945.19739835134;5952.345242023287;5929.318128415115;5948.434898684618;5955.166276721349;6092.299385570716;6103.969480152571;5697.857553561194;5710;5763.625364351304;5769.509591684754;5789.9710501447225;5814.680192589448;5847.883042339215;5856;5861.648301101947;5868.3251426084835;5481.588880834033;5652.349979752216;5704.087346024616;5752.252207213036;5774.538036957118;5572.3034620672415;5595.272614560081;5608.38307786135;5675.914861277001;5693.373728889902;5601.495865372136;5606.18710286998;5610.0743377343915;5613.915791263216;5616.719164041863;5701.7149142541875;5734.111212762028;5734.5125664319;5743.4543718346695;5746.770129194785;5568.303962004749;5571.60998730085;5617.297837770278;5624.521915637217;5627.8874422512135 23:28:50 INFO - PROCESS | 23461 | |1;ext.html;564.4327450911833;641.8267067891669;650.8210242183399;656.6486929492721;670.9533128319824;38253.80873095634;42403.363949540784;42571.57428425715;42683.573164268346;42795.78602106989;42358.36462453066;42901;42965;42971.78514107425;43219.13561728763;8664.999999999984;8795.824083518326;8803.295736341077;8814.603342849556;8823.60293786778;8639.95680021599;8667.69663061793;8732.825343493127;8760.824783504326;8767.298616110727;8739.344549158806;8788.956055219714;8825.602847871829;8845.469271843709;8850.070742572034;8733.388662793575;8754;8781.38530302876;8782.956085219534;8806.86789698155;8425.578721063923;8517.233448989558;8549.230569248735;8583.442076265086;8589.141085891424;40143.598564014275;40260;40295.7985210075;40339.394909076385;40535.18929621391;3430.3139372125424;3467.947980780265;3789.905252368685;4188.141431006637;4272.551382104896;32152;32277.838610806797;32533.837330813432;32591.09311740884;32681;4178.770167640779;4245.681573881971;4252.362145678142;4340.47914250292;4389.956100438987;347528;347786;347803.9999999975;348010;348603;56354.59113522195;56444.43555564392;56830.71584642133;57132;57407;36068;36558.45162322567;36804.631953680655;38034.239315214094;38241.617583823805;15234.314455849513;15284.159371234466;15331.770023449657;15357.23213839326;15364.078155310717;13039.543615973396;13043.543475978295;13070.411831467607;13144.671383215305;13170.143940643828;19420;19509.079386623776;19579.216831326587;19611.803881961285;19671.704924426143;7186.892196617055;7478.5138965967035;7564.659590318449;7614.200508946592;7707.537547747153;1055.7888422315414;1123.9434931164678;1155.364549497773;1168.824676298562;1195.4799662146993;32320.83839580787;32625.836870815496;32731;32929.176770580925;32938.67061329356;1150.71232191952;1173.8884805943421;1174.618249069056;1184.3190165654783;1209.5152505176195;16089.115098669452;16513.587160320847;16669.416570419977;17142;17178.828211717973;502668;506738;517445;518581;519686;58052.70973645189;58175;58225.417745822844;58427.41572584305;58594.707026464595;1404.5365029540228;1417.730631180093;1476.6529865481602;1480.3412481445653;1484.7921291019265;30353.392932140792;32137.839310803298;32643;32650.34699305953;33138;52193.217101742746;52685;52799.47200527946;52912.20631690451;53067;503637;505130;505388;510965;511665;42578.5742142587;43299.7835010823;43660.56339436692;44059.11881762411;46825.531744682114;47704.7614761924;47844.28233576429;47998.280025798944;48798.75600622116;49478.50521494739;40843.79578102209;41589.37615935824;41785.58214417939;42679.35980960226;43371.34942975921;40905.97735056647;40915;41311.737652469026;41367;41730.37404438875;35599.82200089087;41061.38407923943;41152.38271425871;41214.38178427386;41240.79379603203;35077.47383789296;36103.09742256465;36714.4492832613;37012.44481332728;37172.81413592915;27581.31046723848;27891.581626275216;28129.71870281271;28673.28316792097;29596.408071838872 23:28:50 INFO - PROCESS | 23461 | |2;jquery.html;378.4550247643393;380.12191836856863;380.34200832559674;387.62400471542594;394.603423559323;14761;17645.735313970286;18314.816851831478;19471.707924381146;19608.509787255327;17306.82693173068;17775.11124443779;17898.463046108605;18202.180901859414;18285.177167027483;5235.842924712265;5387.595930305233;5529.447055294479;5761.971190144043;5763.308402991647;5647.7458514366745;5678.886422271552;5698.1452782082815;5716.28546431696;5752.309722833245;5645.915311270334;5679.829605111853;5680.9715951420185;5692.117721753135;5694.629849059818;5482.533984611313;5584.944150558483;5595.888082238353;5632.183333416631;5692.459216374458;4906.828261010884;4992.450830408652;5013.222950442687;5042.747862606855;5049.293098966147;21872.671909921362;22452.663210051862;22923.82223688747;23093.19173828908;23149;2402.5675378431874;2413.6138217885054;2465.630155476675;2489.3154382544762;2819.238805522518;12784.296863672495;13513.14982880549;14375.353109110116;14535.78196327056;14773.482928097572;1978.4262563856464;1978.7328710624026;1981.1580078466739;2012.7685316188679;2016.9495762606052;73076.63461682711;74560;75046.99999999945;75554.24445755527;75713.62143189249;10436;10507.31702439339;10717.624883129052;10810.35137891729;11167.776644467227;12728.23630582168;13572.592822215349;14645.340959656842;14680.706385872436;14693;7502.474826762074;7775.688972441039;8058.194180581895;8248.793780155544;8320.542370169698;7729.806754831062;7754.961225193838;7805.726799562101;7895.763127106196;8015.919840801634;6540.313267106885;6711.765088221889;6788.898166527506;6798.184217893884;6813.454923606099;1872.597391560821;1884.6136542008855;1907.6375488657388;1933.806619338083;1953.5311525233842;968.8304546704298;1018.9847152292722;1035.3839465518004;1052.952617132231;1087.8150714378576;19343.226270949006;19574.119164637625;19680.507987300432;19737.901310493355;19762.70355944662;1020.1787561013307;1038.8909164537765;1048.8688913885765;1049.8687664041995;1059.4596755654673;10861.402622855661;11151.665450036511;11187.608433704781;11229.989300962952;11268.267562608404;409156;436865;436953;437256;441527;82253;82927.17072829194;82978;83440;84451.99999999878;1023.7747695506977;1045.4145678419957;1080.2978064258139;1102.2064113838023;1114.1977776001265;17029.31882724677;17111.144442777564;17184;17422.738658919872;17794.644107118045;37493.81253093717;37700.43449348317;38706.22587548177;39340.80329598448;39481.40777888391;48898.75550622224;52550.47449525456;52786.472135278156;52807.735961319944;52809.73595132;7050.224475307609;7345.265473452612;7407.740729074457;8481.745547633582;8890.422122562013;8902.287816974756;12343.321117338633;13578.185308881499;13643.113197642122;13774.724505510034;11499.885001150216;11579.857726320657;11689.707757306136;11958.46186921608;12264.75470490603;11706.800846611393;11800.291982481078;11907.106966977339;12228.327441990776;12246;11773.882261177621;11982.820257696316;12011.339376334385;12234.204776689843;12632.873671263169;7393.852122957618;7405.62971851416;7417.962910185414;7704.807379815549;7803.141654418123;10060.597576096874;11805.350705711267;12064.75870482603;12281.44733487013;12304.384780761106 23:28:50 INFO - PROCESS | 23461 | |3;mootools.html;1517.688873780875;1543.6681113560585;1682.7644129821826;1781.3230972230551;1804.8736588438805;7621.161672216052;8204.794880128;8475.872861907077;8755.430896991691;8775.692850750225;8577.914220857789;8597.613107410167;8639.136086391358;8657.61040753166;8671.95664021679;2242.6411774116104;2266.6713326567638;2268.0700912625825;2275.5790178816887;2289.9771002290013;2184.421128400975;2217.323716266538;2239.8432109752325;2253.211376018389;2257.3566533537946;2207.5253820428607;2210.9226177083806;2217;2227.175944900389;2263.207877242968;2168.6855405966126;2180.6728990651372;2185.595664802017;2187.3437968609433;2189.025883481851;2236.6980457638174;2250.313654335427;2253.6056190166655;2256.9548609027893;2258.07418958228;8526.87209691855;8527.232549070552;8568.614412351459;8583.785405364853;8606.87089693655;4858.1012512685265;4971.353724015891;4974.3533340665845;4980.053789779967;4985.1774457214515;3079.8306093164865;3107.829069401182;3238.3847069056806;3289.1777055736065;3299.6205436374885;1069.9358038517637;1082.096449464698;1083.090204228444;1083.7344850511674;1098.7253186703324;11470.483828227667;11512.712182195428;11531.192816502848;11560.190786644938;11577.305361678242;4263.8081286342185;4428.402165707588;4515.616172625298;4519.367288579601;4538.909221815546;9741.951290243504;9755.902440975642;9762.804743905082;9780.41317520951;9795.853062204073;4967.726775027336;5024.120778863684;5030.496950304941;5063.265826455217;5110.28456016158;4284.864510904613;4588.587027167571;4598.494165641777;4627.791749371287;4707.270373092176;3896.473976013259;3953.5058117735284;3999.1801680655394;4007;4049.987503124219;1222.45600707686;1239.504198320679;1242.3415589737454;1243.384524660281;1250.956216532417;902.5757893789909;945.5744914788373;975.6292608808608;993.8857031441477;998.5257002923698;5692.715364231772;5748.281464816898;5875.6180848245585;5964.343922168558;5978.940210597925;423.9872803815891;426.17322394555083;427.0711203133235;427.4101739599333;431.91361727653964;4029;4038.495188101487;4066.3900414937402;4078.1232035112594;4080.510338759368;10245.436500992368;10646.467676616137;10648.254622176373;10698.946505267579;10700.30448020876;10415.42715150674;10452.477376131163;10518.053375196268;10562.788744225227;10563.524641391155;7996.480228785111;8045.557494337868;8060.153683863227;8106.9594652027545;8107.108218096005;5263.973680131575;5380.461953804588;5436.700981446058;5446.237526746179;5505.311836020497;9405.388649737744;9978.201743860618;9979.60081596728;9981;9987.500624968578;9663.758406039906;9894.307398482326;9969.850452243078;10016.298859079794;10087;6960.338767817049;7297.379722723628;7324.780256592311;7550.8867366990635;7563.621818908922;8402.957985210034;8460.407771456184;8470.703525376583;8477.067522572388;8515.701950431952;7491.700331986877;7621.31408173267;7653.617319133909;7805.336546393393;7838.137804841349;7396;7510.887336689845;7575.128860180929;7612.467127301257;7652.273034061755;7057.2237053925055;7085.149782025984;7126.857462850818;7129;7158.3557479824985;4878.658493905393;4882.36529251195;4947.975260123676;5088.338515992898;5093.083245015932;5012.598992080698;5090.41460232078;5103.030424219386;5114.079465696211;5148.30497882781 23:28:50 INFO - PROCESS | 23461 | |4;prototype.html;317.9014505503294;318.88998295588027;321.23706197780274;326.8627176585834;328.62044338788706;5516.889662206753;5530.36400813906;5575.637583557076;5585.245991791102;5674.546036317095;5479.479449452306;5506;5554.888902221953;5573.832785016446;5577.358603760569;4150.875473735785;4191.434156388879;4286.314189729644;4305.720128191673;4312.676549258803;4226.36604509323;4265.637420819234;4289.335153051266;4308.526062133163;4360.149770794696;4222.1766755482695;4239.936400953989;4243.936340954888;4264.722793018444;4273.594008569196;4010.318245898204;4240.088380998101;4242.809073591696;4246.278132717445;4262.147570485899;3657.1588534636917;3669.3945498992634;3676.455888526825;3681.9263614727556;3709.332320182366;5288.947110528922;5293.258943747878;5324.227986941911;5337.386200586943;5352.598555108382;4506.616937560311;4730.314104454869;4750.717306327272;4797.352357431737;4829.468758436569;5694.288213973254;5751.079827227665;5784.8843023139725;5791;5794.710264486759;3962.2471730371135;3972.7219094663387;3974.960250397488;3978.661813745835;3981.581933896928;5778.3066032076;5800.303963524362;5964.403559644088;5971.253593300838;6030.065339872327;4098.405731169023;4101.692373072032;4108.239975604522;4108.732932359387;4116.300228961084;4129.752214867118;4163.2298024865495;4170.290181025825;4170.687198460128;4181.790910454465;4558.384618076583;4781.780645935334;4813.374261346003;4823.204171311694;4856.223004319362;5709.286339207599;5748.741306641211;5769.913451298234;5796;5802.738876750556;1427.2578259305103;1438.6403399150213;1439.1796675894639;1443.9422423102958;1455.9126452412888;904.9819003620022;910.6357457017114;925.1349987761464;948.2319321349729;966.120830044656;5605.215269862222;5631.971840140773;5639.915401268984;5641.971790141105;5651.434856514398;5933.288005439289;5938.198343223696;5954.285485741739;5959.225300710967;5981.162637230791;5413.2150838128255;5499.725013749377;5603.38362780102;5665.235193248941;5671.8865622688145;3150.9684903151133;3159.1470303018054;3172.873085076571;3175;3193.664665210166;5919.644821310735;6096.207493025879;6131.172291740647;6137.754489820447;6145.907811382833;5961.701914904237;5963.493103086286;6024.367441418675;6048.6673232971725;6061.969690151521;6091.223441466319;6102.664353460514;6136.202293701701;6139.079138129227;6185.134081228632;5695.629784064023;5838.357780644211;5931;5948.256467941507;5968.134620480093;5754.165645981393;5806.796762113306;5858.736356863866;5888.440598143169;5947.345791962967;5872.6509396241845;6076.848078798065;6092.238470191226;6114.938850611437;6146.200993870768;4110.77390743512;4113.177364527047;4121.423000779953;4138.716997730713;4143.129942712064;5883.911741323798;5967.791127310524;5968.582199246011;5984.89279483297;6038.51691864641;5533.197686335539;5725.799597014085;5733.569982251264;5808.244928159313;5829.8251052468495;5773.3072031356505;5787.7395517200985;5789.507891829073;5796.913046304393;5810;5502.284702988746;5679.148127780866;5768.711564421846;5771.653700777967;5805.564582656233;5823.417658234142;5842.444967728059;5843.2695913010875;5885.73514191871;5940.257467816523;5490.533304669148;5664.603477756517;5682.488576028178;5702;5707.20099186106 23:28:50 INFO - PROCESS | 23461 | |5;yui.html;685.4208194076006;802.3300544045721;820.8932838730964;828.1221904780937;846.9618867150981;14274.714505709879;15194.696106077885;15223.010504317226;15260.160691161982;15302.923485382558;14079.5072172474;14394.712105757879;14509;14652.853471465309;15071.321790519425;680.4760334542399;804.6580203413555;815.8816971539123;817.9509229446222;818.0674031603976;804.7947773317795;822.2599660305743;822.6668199379261;826.0582935453558;831.8294749576353;854.0520022774715;856.9742907712747;860.8579584368572;866.5493943149559;867.2021739999184;851.1275942159274;852.6333676519095;858.3305022082754;861.7027125641644;863.7624653220352;618.8143556932902;622.8754249150188;623.1587357067967;625.0249610607422;627.3224917089532;13610.183388996691;13613.863861361358;13634.522791702242;13694.452221911111;13778.448862045507;13740.244286564235;13746.243956582384;13844.377003034888;13866.791998120036;13890.374933128034;11512;11579.36313502757;11614.303141811519;11697.590584329508;11747.765044699143;3780.8109594520165;3818.9427158592644;3845.5577608574813;3885.4560361549406;3970.7617542947514;59129.40870591325;59147.704261478844;59827.40172598262;60188.398116019154;60189.398106018816;10518.789624207473;10530.556218667934;10713.83929241062;10732.248742587944;11104.666859994213;19612.11745471457;19643.803561964483;19650.606987860163;19678.114484848214;19731;8141.18588141193;8317.584120793936;8321.417500774887;8407.62165702545;8513.531755753369;4785.851395665015;4794.400699912511;4838.467768545457;4855.271709243641;4917.164082106051;3410.1815564264894;3503.982480087583;3523.788572685647;3524.7356448266482;3528.576570811519;620.5097972601684;622.8567429491243;635.2916498104672;643.4080645805869;643.6588608037747;620.2866703291252;643.6878114114651;663.4095654867172;689.1592257445908;723.6743465440468;9024;9202.007202785348;9358.15776580111;9404.811903761887;9459.38513996588;697.9476539259576;732.9890051649229;734.4895297768106;740.5186628691285;745.5265906149525;4719.7404142772475;4839.637027222972;4895.975520122448;4908.582770464479;4929.75351232437;67224.66387668031;68629.65685171542;70686;70835.29164708286;70937.29062709307;58279.41720582825;62146.37853621406;62295.6885215571;62599.37400625936;62986.37013629897;53977.73011134919;54290.72854635622;54398.18402723962;55175;55710;8856.114388561093;8925.152110549487;8949.32880033987;9018;9046.819063618823;33556.49665255072;33953.32093358169;34251.82874085614;36493.81753091217;37078;46599.53400465952;47202;47342.05315893732;47359;47441;12271.20675021205;12332.445039973043;12349.444275007467;12601.306928119042;12640.620781376574;13199.34003299812;13836.446542138201;14150.575482735534;14157.929210354294;14499.710005800036;12534.811977820158;12632.557860474839;12691.175073620554;13210.141340813201;13385.66535836612;12569.308688021882;12691.175073620185;12776.10567260283;12985.350732463528;13198.736025279633;11887.286762793914;12153.69615759613;12269.386530673251;12273.631791046282;12282;10737;11195.776084478428;11199.816035872927;11273.041791447818;11422.600208992646;10897.237193396386;11126.499307531343;11198.888011119785;11228.270162439416;11473.827892581785 23:28:50 INFO - PROCESS | 23461 | __end_tp_report 23:28:50 INFO - PROCESS | 23461 | __start_cc_report 23:28:50 INFO - PROCESS | 23461 | _x_x_mozilla_cycle_collect,342 23:28:50 INFO - PROCESS | 23461 | __end_cc_report 23:28:50 INFO - PROCESS | 23461 | __startTimestamp1463725730040__endTimestamp 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | ------- Summary: start ------- 23:28:50 INFO - PROCESS | 23461 | Number of tests: 6 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | [#0] dojo.html Cycles:165 Average:5432.54 Median:5627.89 stddev:613.60 (10.9%) stddev-sans-first:589.05 23:28:50 INFO - PROCESS | 23461 | Values: 3161.3 3168.1 3196.0 3206.5 3213.0 5313.0 5313.5 5329.1 5420.9 5442.8 5315.9 5448.6 5462.2 5495.6 5513.1 4931.5 4956.1 5015.3 5093.0 5147.9 4922.6 5108.8 5173.3 5173.8 5188.7 4911.5 4948.9 4999.5 5017.0 5025.0 5007.3 5021.7 5032.9 5034.0 5084.4 5005.2 5006.5 5012.1 5028.4 5032.0 5224.7 5302.7 5314.7 5339.5 5361.8 5819.2 5842.8 5852.3 5859.2 5868.2 5718.2 5881.6 5894.8 5906.6 5928.9 5424.9 5465.0 5483.9 5485.7 5498.7 5898.0 5997.1 5997.3 5998.9 6017.8 5561.3 5669.5 5770.8 5783.0 5787.1 5749.0 5813.5 5826.0 5847.5 5874.0 5597.2 5699.1 5804.5 5811.5 5827.5 5875.1 5882.3 5888.4 5889.2 5903.2 4321.3 4374.9 4396.7 4424.0 4466.9 3968.8 3974.4 3981.0 4007.0 4008.0 5399.7 5672.9 5681.4 5707.3 5717.1 5834.8 5882.6 5891.0 5901.2 5921.5 5625.4 5630.5 5639.2 5649.6 5651.6 4874.3 5020.9 5024.5 5031.8 5082.3 6056.5 6103.3 6122.0 6128.4 6129.4 5933.1 5935.0 5944.2 5945.2 5952.3 5929.3 5948.4 5955.2 6092.3 6104.0 5697.9 5710.0 5763.6 5769.5 5790.0 5814.7 5847.9 5856.0 5861.6 5868.3 5481.6 5652.3 5704.1 5752.3 5774.5 5572.3 5595.3 5608.4 5675.9 5693.4 5601.5 5606.2 5610.1 5613.9 5616.7 5701.7 5734.1 5734.5 5743.5 5746.8 5568.3 5571.6 5617.3 5624.5 5627.9 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | [#1] ext.html Cycles:180 Average:61236.83 Median:22954.57 stddev:122694.56 (534.5%) stddev-sans-first:122954.19 23:28:50 INFO - PROCESS | 23461 | Values: 564.4 641.8 650.8 656.6 671.0 38253.8 42403.4 42571.6 42683.6 42795.8 42358.4 42901.0 42965.0 42971.8 43219.1 8665.0 8795.8 8803.3 8814.6 8823.6 8640.0 8667.7 8732.8 8760.8 8767.3 8739.3 8789.0 8825.6 8845.5 8850.1 8733.4 8754.0 8781.4 8783.0 8806.9 8425.6 8517.2 8549.2 8583.4 8589.1 40143.6 40260.0 40295.8 40339.4 40535.2 3430.3 3467.9 3789.9 4188.1 4272.6 32152.0 32277.8 32533.8 32591.1 32681.0 4178.8 4245.7 4252.4 4340.5 4390.0 347528.0 347786.0 347804.0 348010.0 348603.0 56354.6 56444.4 56830.7 57132.0 57407.0 36068.0 36558.5 36804.6 38034.2 38241.6 15234.3 15284.2 15331.8 15357.2 15364.1 13039.5 13043.5 13070.4 13144.7 13170.1 19420.0 19509.1 19579.2 19611.8 19671.7 7186.9 7478.5 7564.7 7614.2 7707.5 1055.8 1123.9 1155.4 1168.8 1195.5 32320.8 32625.8 32731.0 32929.2 32938.7 1150.7 1173.9 1174.6 1184.3 1209.5 16089.1 16513.6 16669.4 17142.0 17178.8 502668.0 506738.0 517445.0 518581.0 519686.0 58052.7 58175.0 58225.4 58427.4 58594.7 1404.5 1417.7 1476.7 1480.3 1484.8 30353.4 32137.8 32643.0 32650.3 33138.0 52193.2 52685.0 52799.5 52912.2 53067.0 503637.0 505130.0 505388.0 510965.0 511665.0 42578.6 43299.8 43660.6 44059.1 46825.5 47704.8 47844.3 47998.3 48798.8 49478.5 40843.8 41589.4 41785.6 42679.4 43371.3 40906.0 40915.0 41311.7 41367.0 41730.4 35599.8 41061.4 41152.4 41214.4 41240.8 35077.5 36103.1 36714.4 37012.4 37172.8 27581.3 27891.6 28129.7 28673.3 29596.4 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | [#2] jquery.html Cycles:180 Average:26714.71 Median:23008.51 stddev:71251.07 (309.7%) stddev-sans-first:71423.50 23:28:50 INFO - PROCESS | 23461 | Values: 378.5 380.1 380.3 387.6 394.6 14761.0 17645.7 18314.8 19471.7 19608.5 17306.8 17775.1 17898.5 18202.2 18285.2 5235.8 5387.6 5529.4 5762.0 5763.3 5647.7 5678.9 5698.1 5716.3 5752.3 5645.9 5679.8 5681.0 5692.1 5694.6 5482.5 5584.9 5595.9 5632.2 5692.5 4906.8 4992.5 5013.2 5042.7 5049.3 21872.7 22452.7 22923.8 23093.2 23149.0 2402.6 2413.6 2465.6 2489.3 2819.2 12784.3 13513.1 14375.4 14535.8 14773.5 1978.4 1978.7 1981.2 2012.8 2016.9 73076.6 74560.0 75047.0 75554.2 75713.6 10436.0 10507.3 10717.6 10810.4 11167.8 12728.2 13572.6 14645.3 14680.7 14693.0 7502.5 7775.7 8058.2 8248.8 8320.5 7729.8 7755.0 7805.7 7895.8 8015.9 6540.3 6711.8 6788.9 6798.2 6813.5 1872.6 1884.6 1907.6 1933.8 1953.5 968.8 1019.0 1035.4 1053.0 1087.8 19343.2 19574.1 19680.5 19737.9 19762.7 1020.2 1038.9 1048.9 1049.9 1059.5 10861.4 11151.7 11187.6 11230.0 11268.3 409156.0 436865.0 436953.0 437256.0 441527.0 82253.0 82927.2 82978.0 83440.0 84452.0 1023.8 1045.4 1080.3 1102.2 1114.2 17029.3 17111.1 17184.0 17422.7 17794.6 37493.8 37700.4 38706.2 39340.8 39481.4 48898.8 52550.5 52786.5 52807.7 52809.7 7050.2 7345.3 7407.7 8481.7 8890.4 8902.3 12343.3 13578.2 13643.1 13774.7 11499.9 11579.9 11689.7 11958.5 12264.8 11706.8 11800.3 11907.1 12228.3 12246.0 11773.9 11982.8 12011.3 12234.2 12632.9 7393.9 7405.6 7418.0 7704.8 7803.1 10060.6 11805.4 12064.8 12281.4 12304.4 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | [#3] mootools.html Cycles:180 Average:5612.99 Median:4957.85 stddev:3200.24 (64.5%) stddev-sans-first:3194.42 23:28:50 INFO - PROCESS | 23461 | Values: 1517.7 1543.7 1682.8 1781.3 1804.9 7621.2 8204.8 8475.9 8755.4 8775.7 8577.9 8597.6 8639.1 8657.6 8672.0 2242.6 2266.7 2268.1 2275.6 2290.0 2184.4 2217.3 2239.8 2253.2 2257.4 2207.5 2210.9 2217.0 2227.2 2263.2 2168.7 2180.7 2185.6 2187.3 2189.0 2236.7 2250.3 2253.6 2257.0 2258.1 8526.9 8527.2 8568.6 8583.8 8606.9 4858.1 4971.4 4974.4 4980.1 4985.2 3079.8 3107.8 3238.4 3289.2 3299.6 1069.9 1082.1 1083.1 1083.7 1098.7 11470.5 11512.7 11531.2 11560.2 11577.3 4263.8 4428.4 4515.6 4519.4 4538.9 9742.0 9755.9 9762.8 9780.4 9795.9 4967.7 5024.1 5030.5 5063.3 5110.3 4284.9 4588.6 4598.5 4627.8 4707.3 3896.5 3953.5 3999.2 4007.0 4050.0 1222.5 1239.5 1242.3 1243.4 1251.0 902.6 945.6 975.6 993.9 998.5 5692.7 5748.3 5875.6 5964.3 5978.9 424.0 426.2 427.1 427.4 431.9 4029.0 4038.5 4066.4 4078.1 4080.5 10245.4 10646.5 10648.3 10698.9 10700.3 10415.4 10452.5 10518.1 10562.8 10563.5 7996.5 8045.6 8060.2 8107.0 8107.1 5264.0 5380.5 5436.7 5446.2 5505.3 9405.4 9978.2 9979.6 9981.0 9987.5 9663.8 9894.3 9969.9 10016.3 10087.0 6960.3 7297.4 7324.8 7550.9 7563.6 8403.0 8460.4 8470.7 8477.1 8515.7 7491.7 7621.3 7653.6 7805.3 7838.1 7396.0 7510.9 7575.1 7612.5 7652.3 7057.2 7085.1 7126.9 7129.0 7158.4 4878.7 4882.4 4948.0 5088.3 5093.1 5012.6 5090.4 5103.0 5114.1 5148.3 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | [#4] prototype.html Cycles:180 Average:4837.39 Median:5618.59 stddev:1450.44 (25.8%) stddev-sans-first:1414.29 23:28:50 INFO - PROCESS | 23461 | Values: 317.9 318.9 321.2 326.9 328.6 5516.9 5530.4 5575.6 5585.2 5674.5 5479.5 5506.0 5554.9 5573.8 5577.4 4150.9 4191.4 4286.3 4305.7 4312.7 4226.4 4265.6 4289.3 4308.5 4360.1 4222.2 4239.9 4243.9 4264.7 4273.6 4010.3 4240.1 4242.8 4246.3 4262.1 3657.2 3669.4 3676.5 3681.9 3709.3 5288.9 5293.3 5324.2 5337.4 5352.6 4506.6 4730.3 4750.7 4797.4 4829.5 5694.3 5751.1 5784.9 5791.0 5794.7 3962.2 3972.7 3975.0 3978.7 3981.6 5778.3 5800.3 5964.4 5971.3 6030.1 4098.4 4101.7 4108.2 4108.7 4116.3 4129.8 4163.2 4170.3 4170.7 4181.8 4558.4 4781.8 4813.4 4823.2 4856.2 5709.3 5748.7 5769.9 5796.0 5802.7 1427.3 1438.6 1439.2 1443.9 1455.9 905.0 910.6 925.1 948.2 966.1 5605.2 5632.0 5639.9 5642.0 5651.4 5933.3 5938.2 5954.3 5959.2 5981.2 5413.2 5499.7 5603.4 5665.2 5671.9 3151.0 3159.1 3172.9 3175.0 3193.7 5919.6 6096.2 6131.2 6137.8 6145.9 5961.7 5963.5 6024.4 6048.7 6062.0 6091.2 6102.7 6136.2 6139.1 6185.1 5695.6 5838.4 5931.0 5948.3 5968.1 5754.2 5806.8 5858.7 5888.4 5947.3 5872.7 6076.8 6092.2 6114.9 6146.2 4110.8 4113.2 4121.4 4138.7 4143.1 5883.9 5967.8 5968.6 5984.9 6038.5 5533.2 5725.8 5733.6 5808.2 5829.8 5773.3 5787.7 5789.5 5796.9 5810.0 5502.3 5679.1 5768.7 5771.7 5805.6 5823.4 5842.4 5843.3 5885.7 5940.3 5490.5 5664.6 5682.5 5702.0 5707.2 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | [#5] yui.html Cycles:180 Average:15671.29 Median:26113.43 stddev:18822.05 (72.1%) stddev-sans-first:18841.21 23:28:50 INFO - PROCESS | 23461 | Values: 685.4 802.3 820.9 828.1 847.0 14274.7 15194.7 15223.0 15260.2 15302.9 14079.5 14394.7 14509.0 14652.9 15071.3 680.5 804.7 815.9 818.0 818.1 804.8 822.3 822.7 826.1 831.8 854.1 857.0 860.9 866.5 867.2 851.1 852.6 858.3 861.7 863.8 618.8 622.9 623.2 625.0 627.3 13610.2 13613.9 13634.5 13694.5 13778.4 13740.2 13746.2 13844.4 13866.8 13890.4 11512.0 11579.4 11614.3 11697.6 11747.8 3780.8 3818.9 3845.6 3885.5 3970.8 59129.4 59147.7 59827.4 60188.4 60189.4 10518.8 10530.6 10713.8 10732.2 11104.7 19612.1 19643.8 19650.6 19678.1 19731.0 8141.2 8317.6 8321.4 8407.6 8513.5 4785.9 4794.4 4838.5 4855.3 4917.2 3410.2 3504.0 3523.8 3524.7 3528.6 620.5 622.9 635.3 643.4 643.7 620.3 643.7 663.4 689.2 723.7 9024.0 9202.0 9358.2 9404.8 9459.4 697.9 733.0 734.5 740.5 745.5 4719.7 4839.6 4896.0 4908.6 4929.8 67224.7 68629.7 70686.0 70835.3 70937.3 58279.4 62146.4 62295.7 62599.4 62986.4 53977.7 54290.7 54398.2 55175.0 55710.0 8856.1 8925.2 8949.3 9018.0 9046.8 33556.5 33953.3 34251.8 36493.8 37078.0 46599.5 47202.0 47342.1 47359.0 47441.0 12271.2 12332.4 12349.4 12601.3 12640.6 13199.3 13836.4 14150.6 14157.9 14499.7 12534.8 12632.6 12691.2 13210.1 13385.7 12569.3 12691.2 12776.1 12985.4 13198.7 11887.3 12153.7 12269.4 12273.6 12282.0 10737.0 11195.8 11199.8 11273.0 11422.6 10897.2 11126.5 11198.9 11228.3 11473.8 23:28:50 INFO - PROCESS | 23461 | -------- Summary: end -------- 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - PROCESS | 23461 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 23:28:50 INFO - PROCESS | 23461 | 23:28:50 INFO - TEST-INFO | 23461: exit 0 23:28:50 INFO - TEST-OK | dromaeo_css | took 1112001ms 23:28:50 INFO - TEST-START | kraken 23:28:50 INFO - operating with platform_type : linux_ 23:28:50 INFO - Initialising browser for kraken test... 23:28:50 INFO - TEST-INFO | started process 23692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppDSiD_/profile http://localhost:37787/getInfo.html) 23:28:54 INFO - PROCESS | 23692 | 23:28:54 INFO - PROCESS | 23692 | (process:23759): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:28:55 INFO - PROCESS | 23692 | __metrics Screen width/height:1600/1200 23:28:55 INFO - PROCESS | 23692 | colorDepth:24 23:28:55 INFO - PROCESS | 23692 | Browser inner width/height: 1024/697 23:28:55 INFO - PROCESS | 23692 | __metrics 23:28:56 ERROR - PROCESS | 23692 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 23:28:56 INFO - TEST-INFO | 23692: exit 0 23:28:56 INFO - Browser initialized. 23:28:56 INFO - Running cycle 1/1 for kraken test... 23:28:56 INFO - TEST-INFO | started process 23810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppDSiD_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:58 INFO - PROCESS | 23810 | 23:28:58 INFO - PROCESS | 23810 | (process:23873): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:29:08 INFO - PROCESS | 23810 | RSS: Main: 163930112 23:29:08 INFO - PROCESS | 23810 | 23:29:11 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37787/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:12 INFO - PROCESS | 23810 | RSS: Main: 168337408 23:29:12 INFO - PROCESS | 23810 | 23:29:14 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37787/tests/kraken/driver.html?testName=audio-dft) 23:29:15 INFO - PROCESS | 23810 | RSS: Main: 168529920 23:29:15 INFO - PROCESS | 23810 | 23:29:18 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37787/tests/kraken/driver.html?testName=audio-fft) 23:29:18 INFO - PROCESS | 23810 | RSS: Main: 162922496 23:29:18 INFO - PROCESS | 23810 | 23:29:21 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37787/tests/kraken/driver.html?testName=audio-oscillator) 23:29:21 INFO - PROCESS | 23810 | RSS: Main: 163446784 23:29:21 INFO - PROCESS | 23810 | 23:29:24 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37787/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:24 INFO - PROCESS | 23810 | RSS: Main: 164126720 23:29:24 INFO - PROCESS | 23810 | 23:29:27 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37787/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:28 INFO - PROCESS | 23810 | RSS: Main: 164282368 23:29:28 INFO - PROCESS | 23810 | 23:29:31 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37787/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:32 INFO - PROCESS | 23810 | RSS: Main: 162873344 23:29:32 INFO - PROCESS | 23810 | 23:29:35 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37787/tests/kraken/driver.html?testName=json-parse-financial) 23:29:36 INFO - PROCESS | 23810 | RSS: Main: 163553280 23:29:36 INFO - PROCESS | 23810 | 23:29:37 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37787/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:38 INFO - PROCESS | 23810 | RSS: Main: 163336192 23:29:38 INFO - PROCESS | 23810 | 23:29:40 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37787/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:40 INFO - PROCESS | 23810 | RSS: Main: 163524608 23:29:40 INFO - PROCESS | 23810 | 23:29:42 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37787/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:43 INFO - PROCESS | 23810 | RSS: Main: 163921920 23:29:43 INFO - PROCESS | 23810 | 23:29:46 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:46 INFO - PROCESS | 23810 | RSS: Main: 164360192 23:29:46 INFO - PROCESS | 23810 | 23:29:49 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:50 INFO - PROCESS | 23810 | RSS: Main: 164409344 23:29:50 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | Cycle 1(1): loaded http://localhost:37787/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37787/tests/kraken/driver.html?testName=ai-astar) 23:29:52 INFO - PROCESS | 23810 | RSS: Main: 165564416 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | __start_tp_report 23:29:52 INFO - PROCESS | 23810 | _x_x_mozilla_page_load 23:29:52 INFO - PROCESS | 23810 | _x_x_mozilla_page_load_details 23:29:52 INFO - PROCESS | 23810 | |i|pagename|runs| 23:29:52 INFO - PROCESS | 23810 | |0;ai-astar;107;110;104;109;111;110;106;109;110;112 23:29:52 INFO - PROCESS | 23810 | |1;audio-beat-detection;148;125;152;218;125;150;155;133;182;126 23:29:52 INFO - PROCESS | 23810 | |2;audio-dft;163;162;161;162;163;166;170;163;162;161 23:29:52 INFO - PROCESS | 23810 | |3;audio-fft;74;75;75;165;75;74;74;75;178;75 23:29:52 INFO - PROCESS | 23810 | |4;audio-oscillator;93;92;184;92;92;93;143;93;93;152 23:29:52 INFO - PROCESS | 23810 | |5;imaging-gaussian-blur;118;117;117;118;118;118;117;119;118;118 23:29:52 INFO - PROCESS | 23810 | |6;imaging-darkroom;146;146;146;146;147;147;148;146;146;147 23:29:52 INFO - PROCESS | 23810 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;96;97 23:29:52 INFO - PROCESS | 23810 | |8;json-parse-financial;57;57;63;57;57;56;56;106;59;55 23:29:52 INFO - PROCESS | 23810 | |9;json-stringify-tinderbox;62;64;62;62;63;62;62;62;62;63 23:29:52 INFO - PROCESS | 23810 | |10;stanford-crypto-aes;83;78;79;78;79;80;79;80;81;80 23:29:52 INFO - PROCESS | 23810 | |11;stanford-crypto-ccm;131;121;132;122;119;124;147;119;191;121 23:29:52 INFO - PROCESS | 23810 | |12;stanford-crypto-pbkdf2;162;164;169;164;161;164;165;174;164;172 23:29:52 INFO - PROCESS | 23810 | |13;stanford-crypto-sha256-iterative;67;66;63;67;63;65;62;66;65;61 23:29:52 INFO - PROCESS | 23810 | __end_tp_report 23:29:52 INFO - PROCESS | 23810 | __start_cc_report 23:29:52 INFO - PROCESS | 23810 | _x_x_mozilla_cycle_collect,837 23:29:52 INFO - PROCESS | 23810 | __end_cc_report 23:29:52 INFO - PROCESS | 23810 | __startTimestamp1463725792420__endTimestamp 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | ------- Summary: start ------- 23:29:52 INFO - PROCESS | 23810 | Number of tests: 14 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.44 (2.2%) stddev-sans-first:2.50 23:29:52 INFO - PROCESS | 23810 | Values: 107.0 110.0 104.0 109.0 111.0 110.0 106.0 109.0 110.0 112.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:151.00 stddev:29.39 (19.5%) stddev-sans-first:31.15 23:29:52 INFO - PROCESS | 23810 | Values: 148.0 125.0 152.0 218.0 125.0 150.0 155.0 133.0 182.0 126.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.75 (1.7%) stddev-sans-first:2.92 23:29:52 INFO - PROCESS | 23810 | Values: 163.0 162.0 161.0 162.0 163.0 166.0 170.0 163.0 162.0 161.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:40.96 (54.6%) stddev-sans-first:42.80 23:29:52 INFO - PROCESS | 23810 | Values: 74.0 75.0 75.0 165.0 75.0 74.0 74.0 75.0 178.0 75.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#4] audio-oscillator Cycles:10 Average:112.70 Median:92.50 stddev:33.97 (36.7%) stddev-sans-first:35.27 23:29:52 INFO - PROCESS | 23810 | Values: 93.0 92.0 184.0 92.0 92.0 93.0 143.0 93.0 93.0 152.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 23:29:52 INFO - PROCESS | 23810 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 117.0 119.0 118.0 118.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:29:52 INFO - PROCESS | 23810 | Values: 146.0 146.0 146.0 146.0 147.0 147.0 148.0 146.0 146.0 147.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 23:29:52 INFO - PROCESS | 23810 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 97.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:57.00 stddev:15.51 (27.2%) stddev-sans-first:16.34 23:29:52 INFO - PROCESS | 23810 | Values: 57.0 57.0 63.0 57.0 57.0 56.0 56.0 106.0 59.0 55.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 23:29:52 INFO - PROCESS | 23810 | Values: 62.0 64.0 62.0 62.0 63.0 62.0 62.0 62.0 62.0 63.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:1.49 (1.9%) stddev-sans-first:1.00 23:29:52 INFO - PROCESS | 23810 | Values: 83.0 78.0 79.0 78.0 79.0 80.0 79.0 80.0 81.0 80.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:127.50 stddev:22.23 (17.4%) stddev-sans-first:23.57 23:29:52 INFO - PROCESS | 23810 | Values: 131.0 121.0 132.0 122.0 119.0 124.0 147.0 119.0 191.0 121.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:164.50 stddev:4.31 (2.6%) stddev-sans-first:4.33 23:29:52 INFO - PROCESS | 23810 | Values: 162.0 164.0 169.0 164.0 161.0 164.0 165.0 174.0 164.0 172.0 23:29:52 INFO - PROCESS | 23810 | 23:29:52 INFO - PROCESS | 23810 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.50 stddev:2.12 (3.2%) stddev-sans-first:2.05 23:29:52 INFO - PROCESS | 23810 | Values: 67.0 66.0 63.0 67.0 63.0 65.0 62.0 66.0 65.0 61.0 23:29:52 INFO - PROCESS | 23810 | -------- Summary: end -------- 23:29:52 INFO - PROCESS | 23810 | 23:29:53 INFO - TEST-INFO | 23810: exit 0 23:29:53 INFO - TEST-OK | kraken | took 62613ms 23:29:53 INFO - SUITE-END | took 1174s 23:29:53 INFO - Completed test suite (00:19:34) 23:29:53 INFO - javascript benchmark 23:29:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7148.442923605827, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.336119414923, 3168.097092328687, 3195.9840200799, 3206.470932296171, 3213.0200288911888, 5312.999999999995, 5313.495217954293, 5329.147336426173, 5420.864478388043, 5442.83671489855, 5315.920261196085, 5448.591355648332, 5462.180672899067, 5495.587830912677, 5513.145462453326, 4931.531504507075, 4956.058348913695, 5015.272785446108, 5092.974535127338, 5147.897042059157, 4922.630802689795, 5108.824970256843, 5173.327467429229, 5173.844784656466, 5188.7146206958605, 4911.484294149099, 4948.851534453954, 4999.475055119215, 5016.974915125401, 5025.020121076392, 5007.273945277951, 5021.69869807809, 5032.924506132411, 5034.043531728959, 5084.44071152173, 5005.199168133117, 5006.474320196364, 5012.0727665381655, 5028.421731500887, 5031.974840125813, 5224.686518808883, 5302.681839089667, 5314.73426328682, 5339.466053394668, 5361.785528578852, 5819.214406055171, 5842.766289348421, 5852.326982397036, 5859.1504231886565, 5868.178455016301, 5718.228039214694, 5881.647101173943, 5894.793682221145, 5906.616069955439, 5928.881422371572, 5424.891502169935, 5465.043617366945, 5483.945160548384, 5485.6982865942355, 5498.725063746797, 5898.0, 5997.100434934795, 5997.280326360865, 5998.880022399528, 6017.759289628453, 5561.277033985637, 5669.489745922887, 5770.798022069207, 5783.0, 5787.1319302104175, 5748.965186266512, 5813.476787089182, 5825.970870145622, 5847.532197424196, 5874.030784920526, 5597.244372009808, 5699.088145896637, 5804.535637149018, 5811.506021988093, 5827.504662103769, 5875.11873219012, 5882.294124705063, 5888.440598143169, 5889.234399528034, 5903.203067585907, 4321.330193819963, 4374.934375984363, 4396.736195828261, 4423.955760442419, 4466.865994020184, 3968.7618742874943, 3974.364101743707, 3980.960190398059, 4007.038310805444, 4007.959920400817, 5399.70301633414, 5672.943270567242, 5681.375048744718, 5707.286589176353, 5717.085266357363, 5834.795782147605, 5882.558808089325, 5890.969080410911, 5901.17383566301, 5921.526277897758, 5625.353084395347, 5630.5495560355075, 5639.182318563785, 5649.6327738696855, 5651.6043876928225, 4874.268859671078, 5020.924686129711, 5024.547790698854, 5031.77357018935, 5082.313887625197, 6056.454919057306, 6103.337669688931, 6121.950611746565, 6128.380904898417, 6129.392748099212, 5933.080372542263, 5934.999999999914, 5944.227250457413, 5945.19739835134, 5952.345242023287, 5929.318128415115, 5948.434898684618, 5955.166276721349, 6092.299385570716, 6103.969480152571, 5697.857553561194, 5710.0, 5763.625364351304, 5769.509591684754, 5789.9710501447225, 5814.680192589448, 5847.883042339215, 5856.0, 5861.648301101947, 5868.3251426084835, 5481.588880834033, 5652.349979752216, 5704.087346024616, 5752.252207213036, 5774.538036957118, 5572.3034620672415, 5595.272614560081, 5608.38307786135, 5675.914861277001, 5693.373728889902, 5601.495865372136, 5606.18710286998, 5610.0743377343915, 5613.915791263216, 5616.719164041863, 5701.7149142541875, 5734.111212762028, 5734.5125664319, 5743.4543718346695, 5746.770129194785, 5568.303962004749, 5571.60998730085, 5617.297837770278, 5624.521915637217, 5627.8874422512135], "value": 5391.441259557433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4327450911833, 641.8267067891669, 650.8210242183399, 656.6486929492721, 670.9533128319824, 38253.80873095634, 42403.363949540784, 42571.57428425715, 42683.573164268346, 42795.78602106989, 42358.36462453066, 42901.0, 42965.0, 42971.78514107425, 43219.13561728763, 8664.999999999984, 8795.824083518326, 8803.295736341077, 8814.603342849556, 8823.60293786778, 8639.95680021599, 8667.69663061793, 8732.825343493127, 8760.824783504326, 8767.298616110727, 8739.344549158806, 8788.956055219714, 8825.602847871829, 8845.469271843709, 8850.070742572034, 8733.388662793575, 8754.0, 8781.38530302876, 8782.956085219534, 8806.86789698155, 8425.578721063923, 8517.233448989558, 8549.230569248735, 8583.442076265086, 8589.141085891424, 40143.598564014275, 40260.0, 40295.7985210075, 40339.394909076385, 40535.18929621391, 3430.3139372125424, 3467.947980780265, 3789.905252368685, 4188.141431006637, 4272.551382104896, 32152.0, 32277.838610806797, 32533.837330813432, 32591.09311740884, 32681.0, 4178.770167640779, 4245.681573881971, 4252.362145678142, 4340.47914250292, 4389.956100438987, 347528.0, 347786.0, 347803.9999999975, 348010.0, 348603.0, 56354.59113522195, 56444.43555564392, 56830.71584642133, 57132.0, 57407.0, 36068.0, 36558.45162322567, 36804.631953680655, 38034.239315214094, 38241.617583823805, 15234.314455849513, 15284.159371234466, 15331.770023449657, 15357.23213839326, 15364.078155310717, 13039.543615973396, 13043.543475978295, 13070.411831467607, 13144.671383215305, 13170.143940643828, 19420.0, 19509.079386623776, 19579.216831326587, 19611.803881961285, 19671.704924426143, 7186.892196617055, 7478.5138965967035, 7564.659590318449, 7614.200508946592, 7707.537547747153, 1055.7888422315414, 1123.9434931164678, 1155.364549497773, 1168.824676298562, 1195.4799662146993, 32320.83839580787, 32625.836870815496, 32731.0, 32929.176770580925, 32938.67061329356, 1150.71232191952, 1173.8884805943421, 1174.618249069056, 1184.3190165654783, 1209.5152505176195, 16089.115098669452, 16513.587160320847, 16669.416570419977, 17142.0, 17178.828211717973, 502668.0, 506738.0, 517445.0, 518581.0, 519686.0, 58052.70973645189, 58175.0, 58225.417745822844, 58427.41572584305, 58594.707026464595, 1404.5365029540228, 1417.730631180093, 1476.6529865481602, 1480.3412481445653, 1484.7921291019265, 30353.392932140792, 32137.839310803298, 32643.0, 32650.34699305953, 33138.0, 52193.217101742746, 52685.0, 52799.47200527946, 52912.20631690451, 53067.0, 503637.0, 505130.0, 505388.0, 510965.0, 511665.0, 42578.5742142587, 43299.7835010823, 43660.56339436692, 44059.11881762411, 46825.531744682114, 47704.7614761924, 47844.28233576429, 47998.280025798944, 48798.75600622116, 49478.50521494739, 40843.79578102209, 41589.37615935824, 41785.58214417939, 42679.35980960226, 43371.34942975921, 40905.97735056647, 40915.0, 41311.737652469026, 41367.0, 41730.37404438875, 35599.82200089087, 41061.38407923943, 41152.38271425871, 41214.38178427386, 41240.79379603203, 35077.47383789296, 36103.09742256465, 36714.4492832613, 37012.44481332728, 37172.81413592915, 27581.31046723848, 27891.581626275216, 28129.71870281271, 28673.28316792097, 29596.408071838872], "value": 20276.97197570373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.4550247643393, 380.12191836856863, 380.34200832559674, 387.62400471542594, 394.603423559323, 14761.0, 17645.735313970286, 18314.816851831478, 19471.707924381146, 19608.509787255327, 17306.82693173068, 17775.11124443779, 17898.463046108605, 18202.180901859414, 18285.177167027483, 5235.842924712265, 5387.595930305233, 5529.447055294479, 5761.971190144043, 5763.308402991647, 5647.7458514366745, 5678.886422271552, 5698.1452782082815, 5716.28546431696, 5752.309722833245, 5645.915311270334, 5679.829605111853, 5680.9715951420185, 5692.117721753135, 5694.629849059818, 5482.533984611313, 5584.944150558483, 5595.888082238353, 5632.183333416631, 5692.459216374458, 4906.828261010884, 4992.450830408652, 5013.222950442687, 5042.747862606855, 5049.293098966147, 21872.671909921362, 22452.663210051862, 22923.82223688747, 23093.19173828908, 23149.0, 2402.5675378431874, 2413.6138217885054, 2465.630155476675, 2489.3154382544762, 2819.238805522518, 12784.296863672495, 13513.14982880549, 14375.353109110116, 14535.78196327056, 14773.482928097572, 1978.4262563856464, 1978.7328710624026, 1981.1580078466739, 2012.7685316188679, 2016.9495762606052, 73076.63461682711, 74560.0, 75046.99999999945, 75554.24445755527, 75713.62143189249, 10436.0, 10507.31702439339, 10717.624883129052, 10810.35137891729, 11167.776644467227, 12728.23630582168, 13572.592822215349, 14645.340959656842, 14680.706385872436, 14693.0, 7502.474826762074, 7775.688972441039, 8058.194180581895, 8248.793780155544, 8320.542370169698, 7729.806754831062, 7754.961225193838, 7805.726799562101, 7895.763127106196, 8015.919840801634, 6540.313267106885, 6711.765088221889, 6788.898166527506, 6798.184217893884, 6813.454923606099, 1872.597391560821, 1884.6136542008855, 1907.6375488657388, 1933.806619338083, 1953.5311525233842, 968.8304546704298, 1018.9847152292722, 1035.3839465518004, 1052.952617132231, 1087.8150714378576, 19343.226270949006, 19574.119164637625, 19680.507987300432, 19737.901310493355, 19762.70355944662, 1020.1787561013307, 1038.8909164537765, 1048.8688913885765, 1049.8687664041995, 1059.4596755654673, 10861.402622855661, 11151.665450036511, 11187.608433704781, 11229.989300962952, 11268.267562608404, 409156.0, 436865.0, 436953.0, 437256.0, 441527.0, 82253.0, 82927.17072829194, 82978.0, 83440.0, 84451.99999999878, 1023.7747695506977, 1045.4145678419957, 1080.2978064258139, 1102.2064113838023, 1114.1977776001265, 17029.31882724677, 17111.144442777564, 17184.0, 17422.738658919872, 17794.644107118045, 37493.81253093717, 37700.43449348317, 38706.22587548177, 39340.80329598448, 39481.40777888391, 48898.75550622224, 52550.47449525456, 52786.472135278156, 52807.735961319944, 52809.73595132, 7050.224475307609, 7345.265473452612, 7407.740729074457, 8481.745547633582, 8890.422122562013, 8902.287816974756, 12343.321117338633, 13578.185308881499, 13643.113197642122, 13774.724505510034, 11499.885001150216, 11579.857726320657, 11689.707757306136, 11958.46186921608, 12264.75470490603, 11706.800846611393, 11800.291982481078, 11907.106966977339, 12228.327441990776, 12246.0, 11773.882261177621, 11982.820257696316, 12011.339376334385, 12234.204776689843, 12632.873671263169, 7393.852122957618, 7405.62971851416, 7417.962910185414, 7704.807379815549, 7803.141654418123, 10060.597576096874, 11805.350705711267, 12064.75870482603, 12281.44733487013, 12304.384780761106], "value": 9156.839708107564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.688873780875, 1543.6681113560585, 1682.7644129821826, 1781.3230972230551, 1804.8736588438805, 7621.161672216052, 8204.794880128, 8475.872861907077, 8755.430896991691, 8775.692850750225, 8577.914220857789, 8597.613107410167, 8639.136086391358, 8657.61040753166, 8671.95664021679, 2242.6411774116104, 2266.6713326567638, 2268.0700912625825, 2275.5790178816887, 2289.9771002290013, 2184.421128400975, 2217.323716266538, 2239.8432109752325, 2253.211376018389, 2257.3566533537946, 2207.5253820428607, 2210.9226177083806, 2217.0, 2227.175944900389, 2263.207877242968, 2168.6855405966126, 2180.6728990651372, 2185.595664802017, 2187.3437968609433, 2189.025883481851, 2236.6980457638174, 2250.313654335427, 2253.6056190166655, 2256.9548609027893, 2258.07418958228, 8526.87209691855, 8527.232549070552, 8568.614412351459, 8583.785405364853, 8606.87089693655, 4858.1012512685265, 4971.353724015891, 4974.3533340665845, 4980.053789779967, 4985.1774457214515, 3079.8306093164865, 3107.829069401182, 3238.3847069056806, 3289.1777055736065, 3299.6205436374885, 1069.9358038517637, 1082.096449464698, 1083.090204228444, 1083.7344850511674, 1098.7253186703324, 11470.483828227667, 11512.712182195428, 11531.192816502848, 11560.190786644938, 11577.305361678242, 4263.8081286342185, 4428.402165707588, 4515.616172625298, 4519.367288579601, 4538.909221815546, 9741.951290243504, 9755.902440975642, 9762.804743905082, 9780.41317520951, 9795.853062204073, 4967.726775027336, 5024.120778863684, 5030.496950304941, 5063.265826455217, 5110.28456016158, 4284.864510904613, 4588.587027167571, 4598.494165641777, 4627.791749371287, 4707.270373092176, 3896.473976013259, 3953.5058117735284, 3999.1801680655394, 4007.0, 4049.987503124219, 1222.45600707686, 1239.504198320679, 1242.3415589737454, 1243.384524660281, 1250.956216532417, 902.5757893789909, 945.5744914788373, 975.6292608808608, 993.8857031441477, 998.5257002923698, 5692.715364231772, 5748.281464816898, 5875.6180848245585, 5964.343922168558, 5978.940210597925, 423.9872803815891, 426.17322394555083, 427.0711203133235, 427.4101739599333, 431.91361727653964, 4029.0, 4038.495188101487, 4066.3900414937402, 4078.1232035112594, 4080.510338759368, 10245.436500992368, 10646.467676616137, 10648.254622176373, 10698.946505267579, 10700.30448020876, 10415.42715150674, 10452.477376131163, 10518.053375196268, 10562.788744225227, 10563.524641391155, 7996.480228785111, 8045.557494337868, 8060.153683863227, 8106.9594652027545, 8107.108218096005, 5263.973680131575, 5380.461953804588, 5436.700981446058, 5446.237526746179, 5505.311836020497, 9405.388649737744, 9978.201743860618, 9979.60081596728, 9981.0, 9987.500624968578, 9663.758406039906, 9894.307398482326, 9969.850452243078, 10016.298859079794, 10087.0, 6960.338767817049, 7297.379722723628, 7324.780256592311, 7550.8867366990635, 7563.621818908922, 8402.957985210034, 8460.407771456184, 8470.703525376583, 8477.067522572388, 8515.701950431952, 7491.700331986877, 7621.31408173267, 7653.617319133909, 7805.336546393393, 7838.137804841349, 7396.0, 7510.887336689845, 7575.128860180929, 7612.467127301257, 7652.273034061755, 7057.2237053925055, 7085.149782025984, 7126.857462850818, 7129.0, 7158.3557479824985, 4878.658493905393, 4882.36529251195, 4947.975260123676, 5088.338515992898, 5093.083245015932, 5012.598992080698, 5090.41460232078, 5103.030424219386, 5114.079465696211, 5148.30497882781], "value": 4417.709236094266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.9014505503294, 318.88998295588027, 321.23706197780274, 326.8627176585834, 328.62044338788706, 5516.889662206753, 5530.36400813906, 5575.637583557076, 5585.245991791102, 5674.546036317095, 5479.479449452306, 5506.0, 5554.888902221953, 5573.832785016446, 5577.358603760569, 4150.875473735785, 4191.434156388879, 4286.314189729644, 4305.720128191673, 4312.676549258803, 4226.36604509323, 4265.637420819234, 4289.335153051266, 4308.526062133163, 4360.149770794696, 4222.1766755482695, 4239.936400953989, 4243.936340954888, 4264.722793018444, 4273.594008569196, 4010.318245898204, 4240.088380998101, 4242.809073591696, 4246.278132717445, 4262.147570485899, 3657.1588534636917, 3669.3945498992634, 3676.455888526825, 3681.9263614727556, 3709.332320182366, 5288.947110528922, 5293.258943747878, 5324.227986941911, 5337.386200586943, 5352.598555108382, 4506.616937560311, 4730.314104454869, 4750.717306327272, 4797.352357431737, 4829.468758436569, 5694.288213973254, 5751.079827227665, 5784.8843023139725, 5791.0, 5794.710264486759, 3962.2471730371135, 3972.7219094663387, 3974.960250397488, 3978.661813745835, 3981.581933896928, 5778.3066032076, 5800.303963524362, 5964.403559644088, 5971.253593300838, 6030.065339872327, 4098.405731169023, 4101.692373072032, 4108.239975604522, 4108.732932359387, 4116.300228961084, 4129.752214867118, 4163.2298024865495, 4170.290181025825, 4170.687198460128, 4181.790910454465, 4558.384618076583, 4781.780645935334, 4813.374261346003, 4823.204171311694, 4856.223004319362, 5709.286339207599, 5748.741306641211, 5769.913451298234, 5796.0, 5802.738876750556, 1427.2578259305103, 1438.6403399150213, 1439.1796675894639, 1443.9422423102958, 1455.9126452412888, 904.9819003620022, 910.6357457017114, 925.1349987761464, 948.2319321349729, 966.120830044656, 5605.215269862222, 5631.971840140773, 5639.915401268984, 5641.971790141105, 5651.434856514398, 5933.288005439289, 5938.198343223696, 5954.285485741739, 5959.225300710967, 5981.162637230791, 5413.2150838128255, 5499.725013749377, 5603.38362780102, 5665.235193248941, 5671.8865622688145, 3150.9684903151133, 3159.1470303018054, 3172.873085076571, 3175.0, 3193.664665210166, 5919.644821310735, 6096.207493025879, 6131.172291740647, 6137.754489820447, 6145.907811382833, 5961.701914904237, 5963.493103086286, 6024.367441418675, 6048.6673232971725, 6061.969690151521, 6091.223441466319, 6102.664353460514, 6136.202293701701, 6139.079138129227, 6185.134081228632, 5695.629784064023, 5838.357780644211, 5931.0, 5948.256467941507, 5968.134620480093, 5754.165645981393, 5806.796762113306, 5858.736356863866, 5888.440598143169, 5947.345791962967, 5872.6509396241845, 6076.848078798065, 6092.238470191226, 6114.938850611437, 6146.200993870768, 4110.77390743512, 4113.177364527047, 4121.423000779953, 4138.716997730713, 4143.129942712064, 5883.911741323798, 5967.791127310524, 5968.582199246011, 5984.89279483297, 6038.51691864641, 5533.197686335539, 5725.799597014085, 5733.569982251264, 5808.244928159313, 5829.8251052468495, 5773.3072031356505, 5787.7395517200985, 5789.507891829073, 5796.913046304393, 5810.0, 5502.284702988746, 5679.148127780866, 5768.711564421846, 5771.653700777967, 5805.564582656233, 5823.417658234142, 5842.444967728059, 5843.2695913010875, 5885.73514191871, 5940.257467816523, 5490.533304669148, 5664.603477756517, 5682.488576028178, 5702.0, 5707.20099186106], "value": 4365.170570859363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4208194076006, 802.3300544045721, 820.8932838730964, 828.1221904780937, 846.9618867150981, 14274.714505709879, 15194.696106077885, 15223.010504317226, 15260.160691161982, 15302.923485382558, 14079.5072172474, 14394.712105757879, 14509.0, 14652.853471465309, 15071.321790519425, 680.4760334542399, 804.6580203413555, 815.8816971539123, 817.9509229446222, 818.0674031603976, 804.7947773317795, 822.2599660305743, 822.6668199379261, 826.0582935453558, 831.8294749576353, 854.0520022774715, 856.9742907712747, 860.8579584368572, 866.5493943149559, 867.2021739999184, 851.1275942159274, 852.6333676519095, 858.3305022082754, 861.7027125641644, 863.7624653220352, 618.8143556932902, 622.8754249150188, 623.1587357067967, 625.0249610607422, 627.3224917089532, 13610.183388996691, 13613.863861361358, 13634.522791702242, 13694.452221911111, 13778.448862045507, 13740.244286564235, 13746.243956582384, 13844.377003034888, 13866.791998120036, 13890.374933128034, 11512.0, 11579.36313502757, 11614.303141811519, 11697.590584329508, 11747.765044699143, 3780.8109594520165, 3818.9427158592644, 3845.5577608574813, 3885.4560361549406, 3970.7617542947514, 59129.40870591325, 59147.704261478844, 59827.40172598262, 60188.398116019154, 60189.398106018816, 10518.789624207473, 10530.556218667934, 10713.83929241062, 10732.248742587944, 11104.666859994213, 19612.11745471457, 19643.803561964483, 19650.606987860163, 19678.114484848214, 19731.0, 8141.18588141193, 8317.584120793936, 8321.417500774887, 8407.62165702545, 8513.531755753369, 4785.851395665015, 4794.400699912511, 4838.467768545457, 4855.271709243641, 4917.164082106051, 3410.1815564264894, 3503.982480087583, 3523.788572685647, 3524.7356448266482, 3528.576570811519, 620.5097972601684, 622.8567429491243, 635.2916498104672, 643.4080645805869, 643.6588608037747, 620.2866703291252, 643.6878114114651, 663.4095654867172, 689.1592257445908, 723.6743465440468, 9024.0, 9202.007202785348, 9358.15776580111, 9404.811903761887, 9459.38513996588, 697.9476539259576, 732.9890051649229, 734.4895297768106, 740.5186628691285, 745.5265906149525, 4719.7404142772475, 4839.637027222972, 4895.975520122448, 4908.582770464479, 4929.75351232437, 67224.66387668031, 68629.65685171542, 70686.0, 70835.29164708286, 70937.29062709307, 58279.41720582825, 62146.37853621406, 62295.6885215571, 62599.37400625936, 62986.37013629897, 53977.73011134919, 54290.72854635622, 54398.18402723962, 55175.0, 55710.0, 8856.114388561093, 8925.152110549487, 8949.32880033987, 9018.0, 9046.819063618823, 33556.49665255072, 33953.32093358169, 34251.82874085614, 36493.81753091217, 37078.0, 46599.53400465952, 47202.0, 47342.05315893732, 47359.0, 47441.0, 12271.20675021205, 12332.445039973043, 12349.444275007467, 12601.306928119042, 12640.620781376574, 13199.34003299812, 13836.446542138201, 14150.575482735534, 14157.929210354294, 14499.710005800036, 12534.811977820158, 12632.557860474839, 12691.175073620554, 13210.141340813201, 13385.66535836612, 12569.308688021882, 12691.175073620185, 12776.10567260283, 12985.350732463528, 13198.736025279633, 11887.286762793914, 12153.69615759613, 12269.386530673251, 12273.631791046282, 12282.0, 10737.0, 11195.776084478428, 11199.816035872927, 11273.041791447818, 11422.600208992646, 10897.237193396386, 11126.499307531343, 11198.888011119785, 11228.270162439416, 11473.827892581785], "value": 6911.4836713919885, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 104.0, 109.0, 111.0, 110.0, 106.0, 109.0, 110.0, 112.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 152.0, 218.0, 125.0, 150.0, 155.0, 133.0, 182.0, 126.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 163.0, 166.0, 170.0, 163.0, 162.0, 161.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 165.0, 75.0, 74.0, 74.0, 75.0, 178.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 184.0, 92.0, 92.0, 93.0, 143.0, 93.0, 93.0, 152.0], "value": 112.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 63.0, 57.0, 57.0, 56.0, 56.0, 106.0, 59.0, 55.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 79.0, 78.0, 79.0, 80.0, 79.0, 80.0, 81.0, 80.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 121.0, 132.0, 122.0, 119.0, 124.0, 147.0, 119.0, 191.0, 121.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 169.0, 164.0, 161.0, 164.0, 165.0, 174.0, 164.0, 172.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 63.0, 67.0, 63.0, 65.0, 62.0, 66.0, 65.0, 61.0], "value": 64.5, "unit": "score"}]}]} 23:29:53 INFO - Return code: 0 23:29:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:29:53 ERROR - # TBPL SUCCESS # 23:29:53 INFO - Running post-action listener: _resource_record_post_action 23:29:53 INFO - ##### 23:29:53 INFO - ##### Finished run-tests step (success) 23:29:53 INFO - ##### 23:29:53 INFO - Running post-run listener: _resource_record_post_run 23:29:53 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 290131968; Read time: 0; Write time: 187196 23:29:53 INFO - TinderboxPrint: CPU usage
13.3% 23:29:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:29:53 INFO - TinderboxPrint: I/O write bytes / time
290,131,968 / 187,196 23:29:53 INFO - TinderboxPrint: CPU idle
8,250.8 (86.7%) 23:29:53 INFO - TinderboxPrint: CPU user
1,219.1 (12.8%) 23:29:53 INFO - TinderboxPrint: Swap in / out
0 / 0 23:29:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1290240; Read time: 0; Write time: 40 23:29:53 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288841728; Read time: 0; Write time: 187156 23:29:54 INFO - Running post-run listener: _upload_blobber_files 23:29:54 INFO - Blob upload gear active. 23:29:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:29:54 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 23:29:54 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:29:54 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:29:54 INFO - (blobuploader) - INFO - Open directory for files ... 23:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:58 INFO - (blobuploader) - INFO - Done attempting. 23:29:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:29:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:29:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:59 INFO - (blobuploader) - INFO - Done attempting. 23:29:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:29:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:00 INFO - (blobuploader) - INFO - Done attempting. 23:30:00 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:00 INFO - Return code: 0 23:30:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:30:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6efbb6889a437489cc405922da8666bfef2ea32770989d50359290b6fea14c0c66a13ff72d8f96371524a08c92ade92c9b4d1b18da0b93de729d7a3f079f9be6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8069cbcaf17e1f40454e8b8ec72d1bcae3eb60e3bd676fba69293b9e089ed9ccbe4b05681cc8a4e94c4f3e7ce9d857eae45b86e9d54d24b227ec61972ccf3391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff60ba86ed5aff90a5771b1dfefaac50958948a7b89c71a2eca295a7e243d33934ae92ef97b366928bb983e6de008fa9fd84fbaaecea82cb4d1ca06a14f9b757"} 23:30:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:30:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:30:00 INFO - Contents: 23:30:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6efbb6889a437489cc405922da8666bfef2ea32770989d50359290b6fea14c0c66a13ff72d8f96371524a08c92ade92c9b4d1b18da0b93de729d7a3f079f9be6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8069cbcaf17e1f40454e8b8ec72d1bcae3eb60e3bd676fba69293b9e089ed9ccbe4b05681cc8a4e94c4f3e7ce9d857eae45b86e9d54d24b227ec61972ccf3391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff60ba86ed5aff90a5771b1dfefaac50958948a7b89c71a2eca295a7e243d33934ae92ef97b366928bb983e6de008fa9fd84fbaaecea82cb4d1ca06a14f9b757"} 23:30:00 INFO - Running post-run listener: copy_logs_to_upload_dir 23:30:00 INFO - Copying logs to upload dir... 23:30:00 INFO - mkdir: /builds/slave/test/build/upload/logs 23:30:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.724784 ========= master_lag: 0.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-19 23:30:00.606634) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 23:30:00.610919) ========= 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=ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002 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/Firefox/sha512/6efbb6889a437489cc405922da8666bfef2ea32770989d50359290b6fea14c0c66a13ff72d8f96371524a08c92ade92c9b4d1b18da0b93de729d7a3f079f9be6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8069cbcaf17e1f40454e8b8ec72d1bcae3eb60e3bd676fba69293b9e089ed9ccbe4b05681cc8a4e94c4f3e7ce9d857eae45b86e9d54d24b227ec61972ccf3391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff60ba86ed5aff90a5771b1dfefaac50958948a7b89c71a2eca295a7e243d33934ae92ef97b366928bb983e6de008fa9fd84fbaaecea82cb4d1ca06a14f9b757"} build_url:https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/c9mwayojRmKMHwSm_8yByg/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/Firefox/sha512/6efbb6889a437489cc405922da8666bfef2ea32770989d50359290b6fea14c0c66a13ff72d8f96371524a08c92ade92c9b4d1b18da0b93de729d7a3f079f9be6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8069cbcaf17e1f40454e8b8ec72d1bcae3eb60e3bd676fba69293b9e089ed9ccbe4b05681cc8a4e94c4f3e7ce9d857eae45b86e9d54d24b227ec61972ccf3391", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ff60ba86ed5aff90a5771b1dfefaac50958948a7b89c71a2eca295a7e243d33934ae92ef97b366928bb983e6de008fa9fd84fbaaecea82cb4d1ca06a14f9b757"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 23:30:00.635279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:30:00.638653) ========= 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=ea34ab03e80221fdf844251c000001a3-1463724126.638103-1832622002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 23:30:00.688301) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 23:30:00.688629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 23:30:00.688912) ========= ========= Total master_lag: 0.61 =========