builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1461070215.15 results: success (0) buildid: 20160419030312 builduid: 95f374b788af453a93c87642c9d437b0 revision: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.151872) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.152512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.152797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.180494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.180777) ========= 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=4300f881736b422476174874000001bc-1461067770.605346-1744972455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 05:50:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-04-19 05:50:15 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.315881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.316224) ========= 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=4300f881736b422476174874000001bc-1461067770.605346-1744972455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015476 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.370744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:15.371095) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ae7413abfa4d3954a6a4ce7c1613a7100f367f9a --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 ae7413abfa4d3954a6a4ce7c1613a7100f367f9a --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=4300f881736b422476174874000001bc-1461067770.605346-1744972455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 05:50:15,957 truncating revision to first 12 chars 2016-04-19 05:50:15,957 Setting DEBUG logging. 2016-04-19 05:50:15,957 attempt 1/10 2016-04-19 05:50:15,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ae7413abfa4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 05:50:16,440 unpacking tar archive at: mozilla-central-ae7413abfa4d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.742786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:16.127846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:16.128151) ========= script_repo_revision: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:16.128530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:16.128804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 05:50:16.137821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-19 05:50:16.138122) ========= /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=4300f881736b422476174874000001bc-1461067770.605346-1744972455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:16 INFO - MultiFileLogger online at 20160419 05:50:16 in /builds/slave/test 05:50:16 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 05:50:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:16 INFO - {'append_to_log': False, 05:50:16 INFO - 'base_work_dir': '/builds/slave/test', 05:50:16 INFO - 'blob_upload_branch': 'Firefox', 05:50:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:16 INFO - 'branch': 'Firefox', 05:50:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:16 INFO - 'config_files': ('talos/linux_config.py',), 05:50:16 INFO - 'default_actions': ('clobber', 05:50:16 INFO - 'read-buildbot-config', 05:50:16 INFO - 'download-and-extract', 05:50:16 INFO - 'populate-webroot', 05:50:16 INFO - 'create-virtualenv', 05:50:16 INFO - 'install', 05:50:16 INFO - 'run-tests'), 05:50:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:16 INFO - 'download_minidump_stackwalk': True, 05:50:16 INFO - 'download_symbols': 'ondemand', 05:50:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:16 INFO - 'installer_path': 'installer.exe', 05:50:16 INFO - 'log_level': 'info', 05:50:16 INFO - 'log_name': 'talos', 05:50:16 INFO - 'log_to_console': True, 05:50:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:16 INFO - 'opt_config_files': (), 05:50:16 INFO - 'pip_index': False, 05:50:16 INFO - 'sps_profile': False, 05:50:16 INFO - 'sps_profile_interval': 0, 05:50:16 INFO - 'suite': 'dromaeojs-e10s', 05:50:16 INFO - 'system_bits': '32', 05:50:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:16 INFO - 'title': 'talos-linux64-ix-045', 05:50:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:16 INFO - 'use_talos_json': True, 05:50:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:16 INFO - 'work_dir': 'build'} 05:50:16 INFO - ##### 05:50:16 INFO - ##### Running clobber step. 05:50:16 INFO - ##### 05:50:16 INFO - Running pre-action listener: _resource_record_pre_action 05:50:16 INFO - Running main action method: clobber 05:50:16 INFO - rmtree: /builds/slave/test/build 05:50:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:17 INFO - Running post-action listener: _resource_record_post_action 05:50:17 INFO - ##### 05:50:17 INFO - ##### Running read-buildbot-config step. 05:50:17 INFO - ##### 05:50:17 INFO - Running pre-action listener: _resource_record_pre_action 05:50:17 INFO - Running main action method: read_buildbot_config 05:50:17 INFO - Using buildbot properties: 05:50:17 INFO - { 05:50:17 INFO - "project": "", 05:50:17 INFO - "product": "firefox", 05:50:17 INFO - "script_repo_revision": "production", 05:50:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:50:17 INFO - "repository": "", 05:50:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:50:17 INFO - "buildid": "20160419030312", 05:50:17 INFO - "stage_platform": "linux64-pgo", 05:50:17 INFO - "basedir": "/builds/slave/test", 05:50:17 INFO - "nightly_build": "True", 05:50:17 INFO - "buildnumber": 704, 05:50:17 INFO - "slavename": "talos-linux64-ix-045", 05:50:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:50:17 INFO - "platform": "ubuntu64_hw", 05:50:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:50:17 INFO - "branch": "mozilla-central", 05:50:17 INFO - "repo_path": "mozilla-central", 05:50:17 INFO - "revision": "ae7413abfa4d3954a6a4ce7c1613a7100f367f9a", 05:50:17 INFO - "pgo_build": "True", 05:50:17 INFO - "builduid": "95f374b788af453a93c87642c9d437b0", 05:50:17 INFO - "slavebuilddir": "test" 05:50:17 INFO - } 05:50:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:50:17 INFO - Running post-action listener: _resource_record_post_action 05:50:17 INFO - ##### 05:50:17 INFO - ##### Running download-and-extract step. 05:50:17 INFO - ##### 05:50:17 INFO - Running pre-action listener: _resource_record_pre_action 05:50:17 INFO - Running main action method: download_and_extract 05:50:17 INFO - mkdir: /builds/slave/test/build/tests 05:50: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')]} 05:50:17 INFO - https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:50:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:50:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:50:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:50:20 INFO - Downloaded 1361 bytes. 05:50:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:50:20 INFO - Using the following test package requirements: 05:50:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:50:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:20 INFO - u'jsshell-linux-x86_64.zip'], 05:50:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:50:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:50:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:20 INFO - https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:50:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:50:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:50:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:21 INFO - Downloaded 23781607 bytes. 05:50:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:50:23 INFO - Return code: 0 05:50:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:23 INFO - https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:50:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:50:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:29 INFO - Downloaded 23781607 bytes. 05:50:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:50:31 INFO - Return code: 0 05:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:31 INFO - https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:50:32 INFO - Downloaded 10845952 bytes. 05:50:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:50:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:50:32 INFO - Return code: 0 05:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:32 INFO - https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:50:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:50:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:50:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:50:33 INFO - Downloaded 58250409 bytes. 05:50:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:50:33 INFO - mkdir: /builds/slave/test/properties 05:50:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:33 INFO - Contents: 05:50:33 INFO - build_url:https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:50:34 INFO - Running post-action listener: _resource_record_post_action 05:50:34 INFO - Running post-action listener: set_extra_try_arguments 05:50:34 INFO - ##### 05:50:34 INFO - ##### Running populate-webroot step. 05:50:34 INFO - ##### 05:50:34 INFO - Running pre-action listener: _resource_record_pre_action 05:50:34 INFO - Running main action method: populate_webroot 05:50:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:34 INFO - '--tppagecycles', 05:50:34 INFO - '7'], 05:50:34 INFO - 'tests': ['tsvgm']}}, 05:50:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:50:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:50:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:34 INFO - 'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:34 INFO - 'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['damp', 'tps']}, 05:50:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:34 INFO - 'tests': ['damp', 'tps']}, 05:50:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['dromaeo_dom']}, 05:50:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['a11yr', 05:50:34 INFO - 'ts_paint', 05:50:34 INFO - 'tpaint', 05:50:34 INFO - 'sessionrestore', 05:50:34 INFO - 'sessionrestore_no_auto_restore', 05:50:34 INFO - 'tabpaint']}, 05:50:34 INFO - 'other-e10s': {'tests': ['a11yr', 05:50:34 INFO - 'ts_paint', 05:50:34 INFO - 'tpaint', 05:50:34 INFO - 'sessionrestore', 05:50:34 INFO - 'sessionrestore_no_auto_restore', 05:50:34 INFO - 'tabpaint']}, 05:50:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:50:34 INFO - 'ts_paint', 05:50:34 INFO - 'tpaint', 05:50:34 INFO - 'sessionrestore', 05:50:34 INFO - 'sessionrestore_no_auto_restore', 05:50:34 INFO - 'tabpaint']}, 05:50:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:50:34 INFO - 'ts_paint', 05:50:34 INFO - 'tpaint', 05:50:34 INFO - 'sessionrestore', 05:50:34 INFO - 'sessionrestore_no_auto_restore', 05:50:34 INFO - 'tabpaint']}, 05:50:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['a11yr', 05:50:34 INFO - 'ts_paint', 05:50:34 INFO - 'tpaint', 05:50:34 INFO - 'sessionrestore', 05:50:34 INFO - 'sessionrestore_no_auto_restore', 05:50:34 INFO - 'tabpaint']}, 05:50:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['a11yr', 05:50:34 INFO - 'ts_paint', 05:50:34 INFO - 'tpaint', 05:50:34 INFO - 'sessionrestore', 05:50:34 INFO - 'sessionrestore_no_auto_restore', 05:50:34 INFO - 'tabpaint']}, 05:50:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['tsvgx', 05:50:34 INFO - 'tsvgr_opacity', 05:50:34 INFO - 'tart', 05:50:34 INFO - 'tscrollx', 05:50:34 INFO - 'cart']}, 05:50:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:50:34 INFO - 'tsvgr_opacity', 05:50:34 INFO - 'tart', 05:50:34 INFO - 'tscrollx', 05:50:34 INFO - 'cart']}, 05:50:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:34 INFO - 'talos_options': ['--disable-e10s'], 05:50:34 INFO - 'tests': ['tp5o']}, 05:50:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:34 INFO - 'tests': ['tp5o']}, 05:50:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:34 INFO - 'talos_options': ['--disable-e10s', 05:50:34 INFO - '--xperf_path', 05:50:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:34 INFO - 'tests': ['tp5n']}, 05:50:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:34 INFO - 'talos_options': ['--xperf_path', 05:50:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:34 INFO - 'tests': ['tp5n']}}, 05:50:34 INFO - 'talos.zip': {'path': '', 05:50:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:34 INFO - Running post-action listener: _resource_record_post_action 05:50:34 INFO - ##### 05:50:34 INFO - ##### Running create-virtualenv step. 05:50:34 INFO - ##### 05:50:34 INFO - Running pre-action listener: _resource_record_pre_action 05:50:34 INFO - Running main action method: create_virtualenv 05:50:34 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:50:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:34 INFO - Using real prefix '/usr' 05:50:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:35 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:37 INFO - Installing pip.................done. 05:50:37 INFO - Return code: 0 05:50:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:37 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 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:50:37 INFO - Using env: {'DISPLAY': ':0', 05:50:37 INFO - 'HOME': '/home/cltbld', 05:50:37 INFO - 'LANG': 'en_US.UTF-8', 05:50:37 INFO - 'LANGUAGE': 'en_US:en', 05:50:37 INFO - 'LOGNAME': 'cltbld', 05:50:37 INFO - 'MAIL': '/var/mail/cltbld', 05:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:37 INFO - 'MOZ_NO_REMOTE': '1', 05:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:37 INFO - 'NO_EM_RESTART': '1', 05:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:37 INFO - 'PWD': '/builds/slave/test', 05:50:37 INFO - 'SHELL': '/bin/bash', 05:50:37 INFO - 'SHLVL': '1', 05:50:37 INFO - 'TERM': 'linux', 05:50:37 INFO - 'TMOUT': '86400', 05:50:37 INFO - 'USER': 'cltbld', 05:50:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:37 INFO - '_': '/tools/buildbot/bin/python'} 05:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:50:37 INFO - Cleaning up... 05:50:37 INFO - Return code: 0 05:50:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:50:37 INFO - Using env: {'DISPLAY': ':0', 05:50:37 INFO - 'HOME': '/home/cltbld', 05:50:37 INFO - 'LANG': 'en_US.UTF-8', 05:50:37 INFO - 'LANGUAGE': 'en_US:en', 05:50:37 INFO - 'LOGNAME': 'cltbld', 05:50:37 INFO - 'MAIL': '/var/mail/cltbld', 05:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:37 INFO - 'MOZ_NO_REMOTE': '1', 05:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:37 INFO - 'NO_EM_RESTART': '1', 05:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:37 INFO - 'PWD': '/builds/slave/test', 05:50:37 INFO - 'SHELL': '/bin/bash', 05:50:37 INFO - 'SHLVL': '1', 05:50:37 INFO - 'TERM': 'linux', 05:50:37 INFO - 'TMOUT': '86400', 05:50:37 INFO - 'USER': 'cltbld', 05:50:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:37 INFO - '_': '/tools/buildbot/bin/python'} 05:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:37 INFO - Downloading/unpacking psutil>=0.7.1 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:39 INFO - Installing collected packages: psutil 05:50:39 INFO - Running setup.py install for psutil 05:50:39 INFO - building 'psutil._psutil_linux' extension 05:50:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:50:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:50:39 INFO - building 'psutil._psutil_posix' extension 05:50:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:50: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:50:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:40 INFO - Successfully installed psutil 05:50:40 INFO - Cleaning up... 05:50:40 INFO - Return code: 0 05:50:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:50:40 INFO - Using env: {'DISPLAY': ':0', 05:50:40 INFO - 'HOME': '/home/cltbld', 05:50:40 INFO - 'LANG': 'en_US.UTF-8', 05:50:40 INFO - 'LANGUAGE': 'en_US:en', 05:50:40 INFO - 'LOGNAME': 'cltbld', 05:50:40 INFO - 'MAIL': '/var/mail/cltbld', 05:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:40 INFO - 'MOZ_NO_REMOTE': '1', 05:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:40 INFO - 'NO_EM_RESTART': '1', 05:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:40 INFO - 'PWD': '/builds/slave/test', 05:50:40 INFO - 'SHELL': '/bin/bash', 05:50:40 INFO - 'SHLVL': '1', 05:50:40 INFO - 'TERM': 'linux', 05:50:40 INFO - 'TMOUT': '86400', 05:50:40 INFO - 'USER': 'cltbld', 05:50:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:40 INFO - '_': '/tools/buildbot/bin/python'} 05:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:50:42 INFO - Installing collected packages: mozsystemmonitor 05:50:42 INFO - Running setup.py install for mozsystemmonitor 05:50:42 INFO - Successfully installed mozsystemmonitor 05:50:42 INFO - Cleaning up... 05:50:42 INFO - Return code: 0 05:50:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:42 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 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:50:42 INFO - Using env: {'DISPLAY': ':0', 05:50:42 INFO - 'HOME': '/home/cltbld', 05:50:42 INFO - 'LANG': 'en_US.UTF-8', 05:50:42 INFO - 'LANGUAGE': 'en_US:en', 05:50:42 INFO - 'LOGNAME': 'cltbld', 05:50:42 INFO - 'MAIL': '/var/mail/cltbld', 05:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:42 INFO - 'MOZ_NO_REMOTE': '1', 05:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:42 INFO - 'NO_EM_RESTART': '1', 05:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:42 INFO - 'PWD': '/builds/slave/test', 05:50:42 INFO - 'SHELL': '/bin/bash', 05:50:42 INFO - 'SHLVL': '1', 05:50:42 INFO - 'TERM': 'linux', 05:50:42 INFO - 'TMOUT': '86400', 05:50:42 INFO - 'USER': 'cltbld', 05:50:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:42 INFO - '_': '/tools/buildbot/bin/python'} 05:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:50:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:45 INFO - Downloading docopt-0.6.1.tar.gz 05:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:45 INFO - Running setup.py install for blobuploader 05:50:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:50:45 INFO - Running setup.py install for requests 05:50:45 INFO - Running setup.py install for docopt 05:50:46 INFO - Successfully installed blobuploader requests docopt 05:50:46 INFO - Cleaning up... 05:50:46 INFO - Return code: 0 05:50:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:46 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 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:46 INFO - Using env: {'DISPLAY': ':0', 05:50:46 INFO - 'HOME': '/home/cltbld', 05:50:46 INFO - 'LANG': 'en_US.UTF-8', 05:50:46 INFO - 'LANGUAGE': 'en_US:en', 05:50:46 INFO - 'LOGNAME': 'cltbld', 05:50:46 INFO - 'MAIL': '/var/mail/cltbld', 05:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:46 INFO - 'MOZ_NO_REMOTE': '1', 05:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:46 INFO - 'NO_EM_RESTART': '1', 05:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:46 INFO - 'PWD': '/builds/slave/test', 05:50:46 INFO - 'SHELL': '/bin/bash', 05:50:46 INFO - 'SHLVL': '1', 05:50:46 INFO - 'TERM': 'linux', 05:50:46 INFO - 'TMOUT': '86400', 05:50:46 INFO - 'USER': 'cltbld', 05:50:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:46 INFO - '_': '/tools/buildbot/bin/python'} 05:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:46 INFO - Running setup.py (path:/tmp/pip-6SpdYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:46 INFO - Running setup.py (path:/tmp/pip-adxQkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:46 INFO - Running setup.py (path:/tmp/pip-XDHc3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:46 INFO - Running setup.py (path:/tmp/pip-lywHHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:46 INFO - Running setup.py (path:/tmp/pip-cASQGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:46 INFO - Running setup.py (path:/tmp/pip-ypjvoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:46 INFO - Running setup.py (path:/tmp/pip-ZKVHiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:46 INFO - Running setup.py (path:/tmp/pip-XEmWq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:46 INFO - Running setup.py (path:/tmp/pip-nv0ki9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:46 INFO - Running setup.py (path:/tmp/pip-A5ZGh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:47 INFO - Running setup.py (path:/tmp/pip-W0AhXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:47 INFO - Running setup.py (path:/tmp/pip-LYfZmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:47 INFO - Running setup.py (path:/tmp/pip-Nm4OTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:47 INFO - Running setup.py (path:/tmp/pip-jRGXE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:47 INFO - Running setup.py (path:/tmp/pip-dFVgrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:47 INFO - Running setup.py (path:/tmp/pip-pMJSqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:47 INFO - Running setup.py (path:/tmp/pip-jZ_rv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:47 INFO - Running setup.py install for manifestparser 05:50:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:47 INFO - Running setup.py install for mozcrash 05:50:47 INFO - Running setup.py install for mozdebug 05:50:47 INFO - Running setup.py install for mozdevice 05:50:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:47 INFO - Running setup.py install for mozfile 05:50:48 INFO - Running setup.py install for mozhttpd 05:50:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozinfo 05:50:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozInstall 05:50:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozleak 05:50:48 INFO - Running setup.py install for mozlog 05:50:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for moznetwork 05:50:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozprocess 05:50:48 INFO - Running setup.py install for mozprofile 05:50:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozrunner 05:50:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:50:48 INFO - Running setup.py install for mozscreenshot 05:50:49 INFO - Running setup.py install for moztest 05:50:49 INFO - Running setup.py install for mozversion 05:50:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:50:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:49 INFO - Cleaning up... 05:50:49 INFO - Return code: 0 05:50:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:49 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 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:49 INFO - Using env: {'DISPLAY': ':0', 05:50:49 INFO - 'HOME': '/home/cltbld', 05:50:49 INFO - 'LANG': 'en_US.UTF-8', 05:50:49 INFO - 'LANGUAGE': 'en_US:en', 05:50:49 INFO - 'LOGNAME': 'cltbld', 05:50:49 INFO - 'MAIL': '/var/mail/cltbld', 05:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:49 INFO - 'MOZ_NO_REMOTE': '1', 05:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:49 INFO - 'NO_EM_RESTART': '1', 05:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:49 INFO - 'PWD': '/builds/slave/test', 05:50:49 INFO - 'SHELL': '/bin/bash', 05:50:49 INFO - 'SHLVL': '1', 05:50:49 INFO - 'TERM': 'linux', 05:50:49 INFO - 'TMOUT': '86400', 05:50:49 INFO - 'USER': 'cltbld', 05:50:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:49 INFO - '_': '/tools/buildbot/bin/python'} 05:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:49 INFO - Running setup.py (path:/tmp/pip-ksEQio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:49 INFO - Running setup.py (path:/tmp/pip-7ZfwDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:49 INFO - Running setup.py (path:/tmp/pip-GYGZ0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:49 INFO - Running setup.py (path:/tmp/pip-YVUqNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:49 INFO - Running setup.py (path:/tmp/pip-6Vn_Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:49 INFO - Running setup.py (path:/tmp/pip-NtMLzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:49 INFO - Running setup.py (path:/tmp/pip-jlj2mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:50 INFO - Running setup.py (path:/tmp/pip-5VNLwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:50 INFO - Running setup.py (path:/tmp/pip-U6gvUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:50 INFO - Running setup.py (path:/tmp/pip-jifGb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:50 INFO - Running setup.py (path:/tmp/pip-LW3ATk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:50 INFO - Running setup.py (path:/tmp/pip-Q6bDNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:50 INFO - Running setup.py (path:/tmp/pip-oOj8Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:50 INFO - Running setup.py (path:/tmp/pip-Mg_4Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:50 INFO - Running setup.py (path:/tmp/pip-lYpy7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:50 INFO - Running setup.py (path:/tmp/pip-3_7SuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:50 INFO - Running setup.py (path:/tmp/pip-aMcVEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:52 INFO - Downloading blessings-1.6.tar.gz 05:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:52 INFO - Installing collected packages: blessings 05:50:52 INFO - Running setup.py install for blessings 05:50:52 INFO - Successfully installed blessings 05:50:52 INFO - Cleaning up... 05:50:52 INFO - Return code: 0 05:50:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:50:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:53 INFO - Reading from file tmpfile_stdout 05:50:53 INFO - Current package versions: 05:50:53 INFO - argparse == 1.2.1 05:50:53 INFO - blessings == 1.6 05:50:53 INFO - blobuploader == 1.2.4 05:50:53 INFO - docopt == 0.6.1 05:50:53 INFO - manifestparser == 1.1 05:50:53 INFO - mozInstall == 1.12 05:50:53 INFO - mozcrash == 0.17 05:50:53 INFO - mozdebug == 0.1 05:50:53 INFO - mozdevice == 0.48 05:50:53 INFO - mozfile == 1.2 05:50:53 INFO - mozhttpd == 0.7 05:50:53 INFO - mozinfo == 0.9 05:50:53 INFO - mozleak == 0.1 05:50:53 INFO - mozlog == 3.1 05:50:53 INFO - moznetwork == 0.27 05:50:53 INFO - mozprocess == 0.22 05:50:53 INFO - mozprofile == 0.28 05:50:53 INFO - mozrunner == 6.11 05:50:53 INFO - mozscreenshot == 0.1 05:50:53 INFO - mozsystemmonitor == 0.0 05:50:53 INFO - moztest == 0.7 05:50:53 INFO - mozversion == 1.4 05:50:53 INFO - psutil == 3.1.1 05:50:53 INFO - requests == 1.2.3 05:50:53 INFO - wsgiref == 0.1.2 05:50:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:53 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 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:53 INFO - Using env: {'DISPLAY': ':0', 05:50:53 INFO - 'HOME': '/home/cltbld', 05:50:53 INFO - 'LANG': 'en_US.UTF-8', 05:50:53 INFO - 'LANGUAGE': 'en_US:en', 05:50:53 INFO - 'LOGNAME': 'cltbld', 05:50:53 INFO - 'MAIL': '/var/mail/cltbld', 05:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:53 INFO - 'MOZ_NO_REMOTE': '1', 05:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:53 INFO - 'NO_EM_RESTART': '1', 05:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:53 INFO - 'PWD': '/builds/slave/test', 05:50:53 INFO - 'SHELL': '/bin/bash', 05:50:53 INFO - 'SHLVL': '1', 05:50:53 INFO - 'TERM': 'linux', 05:50:53 INFO - 'TMOUT': '86400', 05:50:53 INFO - 'USER': 'cltbld', 05:50:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:53 INFO - '_': '/tools/buildbot/bin/python'} 05:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:50:53 INFO - Cleaning up... 05:50:53 INFO - Return code: 0 05:50:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:50:53 INFO - Using env: {'DISPLAY': ':0', 05:50:53 INFO - 'HOME': '/home/cltbld', 05:50:53 INFO - 'LANG': 'en_US.UTF-8', 05:50:53 INFO - 'LANGUAGE': 'en_US:en', 05:50:53 INFO - 'LOGNAME': 'cltbld', 05:50:53 INFO - 'MAIL': '/var/mail/cltbld', 05:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:53 INFO - 'MOZ_NO_REMOTE': '1', 05:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:53 INFO - 'NO_EM_RESTART': '1', 05:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:53 INFO - 'PWD': '/builds/slave/test', 05:50:53 INFO - 'SHELL': '/bin/bash', 05:50:53 INFO - 'SHLVL': '1', 05:50:53 INFO - 'TERM': 'linux', 05:50:53 INFO - 'TMOUT': '86400', 05:50:53 INFO - 'USER': 'cltbld', 05:50:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:53 INFO - '_': '/tools/buildbot/bin/python'} 05:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:53 INFO - Downloading/unpacking jsonschema 05:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:55 INFO - Downloading/unpacking functools32 (from jsonschema) 05:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:55 INFO - warning: no files found matching '*.txt' 05:50:55 INFO - no previously-included directories found matching 'build' 05:50:55 INFO - no previously-included directories found matching 'dist' 05:50:55 INFO - no previously-included directories found matching '.git*' 05:50:55 INFO - Installing collected packages: jsonschema, functools32 05:50:55 INFO - Running setup.py install for functools32 05:50:55 INFO - warning: no files found matching '*.txt' 05:50:55 INFO - no previously-included directories found matching 'build' 05:50:55 INFO - no previously-included directories found matching 'dist' 05:50:55 INFO - no previously-included directories found matching '.git*' 05:50:55 INFO - Successfully installed jsonschema functools32 05:50:55 INFO - Cleaning up... 05:50:55 INFO - Return code: 0 05:50:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:55 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 0x7f635680bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf625a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, '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': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:50:55 INFO - Using env: {'DISPLAY': ':0', 05:50:55 INFO - 'HOME': '/home/cltbld', 05:50:55 INFO - 'LANG': 'en_US.UTF-8', 05:50:55 INFO - 'LANGUAGE': 'en_US:en', 05:50:55 INFO - 'LOGNAME': 'cltbld', 05:50:55 INFO - 'MAIL': '/var/mail/cltbld', 05:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:55 INFO - 'MOZ_NO_REMOTE': '1', 05:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:55 INFO - 'NO_EM_RESTART': '1', 05:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:55 INFO - 'PWD': '/builds/slave/test', 05:50:55 INFO - 'SHELL': '/bin/bash', 05:50:55 INFO - 'SHLVL': '1', 05:50:55 INFO - 'TERM': 'linux', 05:50:55 INFO - 'TMOUT': '86400', 05:50:55 INFO - 'USER': 'cltbld', 05:50:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:55 INFO - '_': '/tools/buildbot/bin/python'} 05:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:56 INFO - Downloading/unpacking flake8 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:50:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:50:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:50:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:58 INFO - no previously-included directories found matching 'docs/_build' 05:50:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:50:58 INFO - Running setup.py install for pep8 05:50:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:58 INFO - no previously-included directories found matching 'docs/_build' 05:50:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:50:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:50:58 INFO - Cleaning up... 05:50:58 INFO - Return code: 0 05:50:58 INFO - Running post-action listener: _resource_record_post_action 05:50:58 INFO - Running post-action listener: _start_resource_monitoring 05:50:59 INFO - Starting resource monitoring. 05:50:59 INFO - ##### 05:50:59 INFO - ##### Running install step. 05:50:59 INFO - ##### 05:50:59 INFO - Running pre-action listener: _resource_record_pre_action 05:50:59 INFO - Running main action method: install 05:50:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:59 INFO - Reading from file tmpfile_stdout 05:50:59 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:59 INFO - Reading from file tmpfile_stdout 05:50:59 INFO - Output received: 05:50:59 INFO - Usage: mozinstall [options] installer 05:50:59 INFO - Options: 05:50:59 INFO - -h, --help show this help message and exit 05:50:59 INFO - -d DEST, --destination=DEST 05:50:59 INFO - Directory to install application into. [default: 05:50:59 INFO - "/builds/slave/test"] 05:50:59 INFO - --app=APP Application being installed. [default: firefox] 05:50:59 INFO - mkdir: /builds/slave/test/build/application 05:50:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:51:15 INFO - Reading from file tmpfile_stdout 05:51:15 INFO - Output received: 05:51:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:15 INFO - Running post-action listener: _resource_record_post_action 05:51:15 INFO - ##### 05:51:15 INFO - ##### Running run-tests step. 05:51:15 INFO - ##### 05:51:15 INFO - Running pre-action listener: _resource_record_pre_action 05:51:15 INFO - Running main action method: run_tests 05:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:15 INFO - Python 2.7.3 05:51:15 INFO - Return code: 0 05:51:15 INFO - grabbing minidump binary from tooltool 05:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff1410>, '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 0xff2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:51:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:51:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:15 INFO - Return code: 0 05:51:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:51:16 INFO - Return code: 0 05:51:16 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/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:51:16 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/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:51:16 INFO - Using env: {'DISPLAY': ':0', 05:51:16 INFO - 'HOME': '/home/cltbld', 05:51:16 INFO - 'LANG': 'en_US.UTF-8', 05:51:16 INFO - 'LANGUAGE': 'en_US:en', 05:51:16 INFO - 'LOGNAME': 'cltbld', 05:51:16 INFO - 'MAIL': '/var/mail/cltbld', 05:51:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:16 INFO - 'MOZ_NO_REMOTE': '1', 05:51:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:16 INFO - 'NO_EM_RESTART': '1', 05:51:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:16 INFO - 'PWD': '/builds/slave/test', 05:51:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:16 INFO - 'SHELL': '/bin/bash', 05:51:16 INFO - 'SHLVL': '1', 05:51:16 INFO - 'TERM': 'linux', 05:51:16 INFO - 'TMOUT': '86400', 05:51:16 INFO - 'USER': 'cltbld', 05:51:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1461067770.605346-1744972455', 05:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:16 INFO - '_': '/tools/buildbot/bin/python'} 05:51:16 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/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:51:17 INFO - mozversion application_buildid: 20160419030312 05:51:17 INFO - mozversion application_changeset: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a 05:51:17 INFO - mozversion application_display_name: Nightly 05:51:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:17 INFO - mozversion application_name: Firefox 05:51:17 INFO - mozversion application_remotingname: firefox 05:51:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:51:17 INFO - mozversion application_vendor: Mozilla 05:51:17 INFO - mozversion application_version: 48.0a1 05:51:17 INFO - mozversion platform_buildid: 20160419030312 05:51:17 INFO - mozversion platform_changeset: ae7413abfa4d3954a6a4ce7c1613a7100f367f9a 05:51:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:51:17 INFO - mozversion platform_version: 48.0a1 05:51:17 INFO - using testdate: 1461070277 05:51:17 INFO - actual date: 1461070277 05:51:17 INFO - starting webserver on 'localhost:56344' 05:51:17 INFO - SUITE-START | Running 2 tests 05:51:17 INFO - TEST-START | dromaeo_css 05:51:17 INFO - operating with platform_type : linux_ 05:51:17 INFO - Initialising browser for dromaeo_css test... 05:51:17 INFO - TEST-INFO | started process 26379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXJ9Z3/profile http://localhost:56344/getInfo.html) 05:51:20 INFO - PROCESS | 26379 | 05:51:20 INFO - PROCESS | 26379 | (process:26449): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:21 INFO - PROCESS | 26379 | __metrics Screen width/height:1600/1200 05:51:21 INFO - PROCESS | 26379 | colorDepth:24 05:51:21 INFO - PROCESS | 26379 | Browser inner width/height: 1024/697 05:51:21 INFO - PROCESS | 26379 | __metrics 05:51:22 ERROR - PROCESS | 26379 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:51:23 INFO - TEST-INFO | 26379: exit 0 05:51:23 INFO - Browser initialized. 05:51:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:23 INFO - TEST-INFO | started process 26500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXJ9Z3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:25 INFO - PROCESS | 26500 | 05:51:25 INFO - PROCESS | 26500 | (process:26560): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:35 INFO - PROCESS | 26500 | RSS: Main: 163315712 05:51:35 INFO - PROCESS | 26500 | 05:52:24 INFO - PROCESS | 26500 | 1461070344961 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:54:32 INFO - PROCESS | 26500 | Cycle 1(1): loaded http://localhost:56344/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56344/tests/dromaeo/cssquery-ext.html) 05:54:33 INFO - PROCESS | 26500 | RSS: Main: 168599552 05:54:33 INFO - PROCESS | 26500 | 05:57:35 INFO - PROCESS | 26500 | Cycle 1(1): loaded http://localhost:56344/tests/dromaeo/cssquery-ext.html (next: http://localhost:56344/tests/dromaeo/cssquery-jquery.html) 05:57:36 INFO - PROCESS | 26500 | RSS: Main: 166125568 05:57:36 INFO - PROCESS | 26500 | 06:00:37 INFO - PROCESS | 26500 | Cycle 1(1): loaded http://localhost:56344/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56344/tests/dromaeo/cssquery-mootools.html) 06:00:38 INFO - PROCESS | 26500 | RSS: Main: 166600704 06:00:38 INFO - PROCESS | 26500 | 06:03:40 INFO - PROCESS | 26500 | Cycle 1(1): loaded http://localhost:56344/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56344/tests/dromaeo/cssquery-prototype.html) 06:03:40 INFO - PROCESS | 26500 | RSS: Main: 164679680 06:03:40 INFO - PROCESS | 26500 | 06:06:43 INFO - PROCESS | 26500 | Cycle 1(1): loaded http://localhost:56344/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56344/tests/dromaeo/cssquery-yui.html) 06:06:43 INFO - PROCESS | 26500 | RSS: Main: 166014976 06:06:43 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | Cycle 1(1): loaded http://localhost:56344/tests/dromaeo/cssquery-yui.html (next: http://localhost:56344/tests/dromaeo/cssquery-dojo.html) 06:09:46 INFO - PROCESS | 26500 | RSS: Main: 168112128 06:09:46 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | __start_tp_report 06:09:46 INFO - PROCESS | 26500 | _x_x_mozilla_page_load 06:09:46 INFO - PROCESS | 26500 | _x_x_mozilla_page_load_details 06:09:46 INFO - PROCESS | 26500 | |i|pagename|runs| 06:09:46 INFO - PROCESS | 26500 | |0;dojo.html;3158.58938338016;3225.225945773015;3238.3685181389637;3281.228911205866;3282.688144626261;5541.307336582932;5566.27638407007;5583.497485226334;5588.441155884409;5592.944070559293;5445.101558242885;5536.363318218406;5565.833025009246;5636.436356364362;5650.5479561635075;5010.098182327189;5019.121653710605;5085.923711144335;5093;5139.280500729901;833.5539260344074;5014.272930425086;5096.745162741867;5104.846854594368;5166.509181627758;5086.618503612225;5088.135017047092;5093.516115969014;5104.387473503166;5128.999845030239;4920.286558449041;5183.118869792107;5189.481051894818;5189.584833213372;5193.63644544882;4968.279599458095;5011.32347133136;5014.097462456756;5026.29631851541;5046.571041461443;5409.540189083893;5429.56563474925;5431.076716958127;5447.891042179134;5449.128139497661;5881.353051164411;5899.705014749288;5909.645421274738;5934.5845790794665;5985.221921150266;5947.078202878518;5955.612885162451;5971.671558064305;5985.5810093293485;6019.879602407971;5460.744028873341;5502.257195278627;5541.196526503675;5557.416471270499;5561.221428999943;5938.703064846741;6069.544784141207;6093.268807743099;6098.159935307505;6107.053406721965;5698.629589076697;5723.341815691166;5736.77052917887;5751.971240143856;5762.971185144132;5838.1242813577455;5903.203067585821;5904.4685978261305;5907.527397808165;5912.467877890925;5780.988327042751;5955.374685657944;5993.61041532299;6006;6063.818085457443;5803.564732645069;5889.793857215062;5908.615939963975;5936.079907614327;6011.1884895539415;4480.708753930984;4484.708493947883;4490.39379683745;4498.280275155959;4526.547345265513;3902.35611124167;3986.9202615948097;3992.84028638857;4035.051762835731;4081.77550234734;5678.829635110953;5680.630759000652;5691.402402747734;5702.914456283159;5713.143028545668;5941.851453713692;5967.671778052249;5997.400259974055;6013.067974463965;6022.45797878193;5483.616146869761;5637.379888212294;5726.885462290814;5745.597808153473;5746.166805813217;5075.746212689424;5096.031753966735;5097.592192624581;5098.770555325019;5114.207297868837;6129.35641757609;6142.32434432221;6145.754169833246;6158.137860699506;6159.753609855556;5831.88336233273;5899.321578018411;5943.138244954544;5973.5519836013345;5997;6157.0456579230295;6167.753289868355;6175.536834737323;6180.536459765625;6181.103739957771;5632.85917852057;5869.589128760946;5902.4097590240635;5905.202797622266;5917.408259174048;5916.408359164049;5935.881282374415;5937.495312898279;5968.432998865101;5984.880302393841;5750.0512415450985;5792.073268277056;5797.594168408171;5831.241938547962;5834.737436815439;5584.134459158837;5812.476877081083;5818.854528636818;5827.9417205829095;5830.387809280134;5529.695866727368;5714.114312281603;5741.081426971665;5796.1305804129715;5827.096799996008;5828.504577110993;5874.353821079592;5875.030619947832;5893.499052580579;5903.380145084704;5560.805371811967;5602.2717046783655;5758.2514273144225;5759.65442073477;5769.249997500298 06:09:46 INFO - PROCESS | 26500 | |1;ext.html;599.8230521996011;644.6615526848404;656.3928366261209;658.8451713847245;662.9436497897678;37142.442863357035;37296;37726;37754.8112259439;38068.23863522728;40644;40997.59002409975;41086.7945660272;41104.58895411045;41550.16899662005;8521.233089021987;8833.07252738463;8847.690330838423;8849.778755531132;8850.468971861677;8717.259032982203;8804.075572064938;8822.11778822119;8834.955825220897;8877.600507977124;8959.552022398886;9032.819343613124;9052.04953479885;9054.637814487412;9066.682666106688;8949.105089491031;8954;8995.685151019716;9028.50343231122;9072.682456114071;8821.161989610977;8913.420627659247;8916.55417229136;8922.643094276222;8957.104289571056;39842.60157398418;39878.401823972665;40107.197856042716;40113.79943100295;40259.39610905839;3388.9322213555592;3521.1197200699826;3542.822858857047;3544.468329750532;3886.24218277436;28277.858610707022;28328.15015549537;28442.431151376855;28564;29266.85366573175;4131.29767939451;4176.2900306947895;4220.725652832556;4307.935380969288;4319.481662200525;263532;264850;267708;271024;271043.999999998;35489.29021419557;36349.636503634625;56268.718656406454;57675.71162144246;57799.711001444724;34080.31839363199;34118.658813411545;34156.48765268523;34157.14607134841;34173.82913085468;14561.199134047518;14988.925055374653;14994.70010599782;14994.70010599782;15001.624959376102;12233.3271670059;12426.62720118398;12473.688157795947;12480.937595312147;12502.562410315777;8529.829403411897;8541.273991710774;8554.401191916506;8604.956975215084;8651.826963460695;3324.883629072971;3381.3575420669995;3390.4914262860766;3392.9321413571593;3400.2689421773944;1083.2471432354596;1088.678839742278;1156.5084838943415;1183.189515182103;1224.3021477757593;31405.842970785;31848.522272165937;32192.83903580514;32348.029559113264;32450.837745811594;1126.4030064066058;1148.7645032768262;1216.519474807464;1229.9877001229872;1235.5860786636576;16590.50228493147;16827.24277407495;16840.073795941094;17123.571910702332;17136.57158571046;474572;478771;480474;480959;481820;56766.71616641973;57117.714411427674;57788.26635200951;57859.42140578625;58022;1351.7837146056584;1395.874371306567;1397.196611948134;1412.7457057729707;1413.0250127412053;30047.248818779706;30267;31778.523322149726;32469.675303246666;35213.64786352104;54809;55922.72038639781;55964.16053759278;56148.719256403456;56152.43847561472;397396;405027;406510;406943;407300;43090.56909430865;43357.3496397548;43824.34263486114;43880.56119438765;44114;47485.287720683526;47964.28053579269;48618.27072593843;48949.2657610129;49453;40073.79963100166;40359.59640403676;41407.792961035004;42178.578214217465;42289.57710422856;40141;40514.59485405108;41111.7944410276;41276.793616031726;42198;41732.1653566933;42409;42608.360874587524;43020.35469468023;43033.56966430296;33152.66847331592;35591.82204088963;35884.820575896956;35937.46093808542;36018.45972310365;24579.631305530787;25240;25282.87358563269;25285.241442756746;25455.74544254608 06:09:46 INFO - PROCESS | 26500 | |2;jquery.html;387.88363490952713;400.82764411303145;401.67464353873345;406.2099217022888;411.5760766410596;13526.458941642348;17698.646027079467;18048.639027219448;18339.44981650551;18422.447326580208;16377.508674739747;16482.25829837657;16493.34026638933;16709.248083836224;17376.131193440342;5179.507946745053;5681.715914204294;5825.796097136601;5857.502112320437;5875.089361149007;6429.35706429358;6435.967820160892;6470.676466176696;6470.870582588345;6471.352864713538;5189.792408303663;5515.751791169387;5518.034343989806;6407.359264073579;6438.7746428875;5339.759710813023;5409.188621706736;5421.9457805422035;5435.864103397407;5827.35899051104;5245.554127899133;5453.23654688344;5483.2049352844015;5518.061929471999;5520.558355331604;11911;12553;12660.55688050923;12671.619851404472;21107.15571377143;2188.1102459522926;2281.8174546036275;2363.468219650582;2605.830621009647;2830.448062627788;9270.072992700743;9929.056739609725;12299.446524906401;13523;13736.244506552135;1757.850582700472;1871.803460636627;1878.8684792064562;1887.7357169996212;1947.5239474049558;70166.64916675435;72447.63776181138;72628.2737172632;74274;74361;9750.707478775648;9777.608895644236;9865.704028879145;10026.298159128937;10159.593616255266;13285.667858303426;13391;13428.462861485432;13435.261060641564;13468.595942121752;7557.508761930457;7630.7710768677025;7679.923200768033;7706.961465192639;7895.249951254622;7408.03695519579;7627.923720762721;7633.770986870402;7697.3072423481035;7746.070471543451;4065.6747460203114;4087.693422993287;4123.546409894909;4185.476815398075;4213.705040647186;1734.2109340250408;1775.698131317679;1799.6850551153495;1814.8185181481747;1819.8635102367375;1008.3294609085023;1041.094248004226;1045.513836066233;1064.3209245295232;1118.8769235384102;17546.473605791845;17736.379226727262;17831.286748529914;17984.820151798576;18114.637707246045;999.9950050199649;1031.9690409287734;1033.7002269341806;1047.701405099543;1103.9448027598587;9412;9569.904300957041;9610.615575377047;9835.3115281931;10130.08829205375;412588;427715;434825;435062;438684;89312;92130;92130.01154924909;92830;92872;1036.0106098675747;1058.3808472043786;1075.091547642241;1092.5465931638282;1094.4965315954591;15306.540803775904;15321.080735155927;15327.846721532642;15522.146281954601;15838.445654402041;35258.294834102664;36212.456813148354;36322.455163172046;36707.81646091752;37330.62669373272;49980.50019499904;51040;53515;54743.72628136834;54947.450525494234;8034.959825200836;8118.472299300526;8283.29591984664;8555.82888342242;8603.440776349516;7203.927960720326;10997.725056873642;12126.75746485083;12178.695532611755;12511.687207819878;11636.185467017227;11645.359505227294;11697.532098715956;11713.121515886172;11755.412229388667;11020.779584408107;11102;11151.832722509007;11181.664550063511;11255.212135150789;5936.1689363488285;9831.525271209375;10581.62964296246;11640.185187036826;11784.941075294568;7252.5648461092505;7515.812104697207;8283.751487455385;8513.914860851311;8530.957345213234;11038.889611103787;11526.250793698382;11648.650540483799;11689;11815.527378904748 06:09:46 INFO - PROCESS | 26500 | |3;mootools.html;1495.8803295736338;1541.6685412636282;1670.2400407814446;1788.01659087502;1811.0854018720545;7607.847843043136;8098.757037288883;8242.711505097323;8438.789030274238;8453.830923381529;8235.299999500035;8261.13258107899;8309.459885107479;8364.623591938362;8372.120927302636;2286.782755638216;2291.4385975435957;2302.4128847143957;2322.6632138339933;2325.093213646679;2269.0810221860174;2284.6001949658826;2322.7212734471805;2323.3959170615594;2325.0699720112007;2313.53729254149;2314.432963923841;2331.40549159964;2333.7782910623464;2337.824663150262;2217.966730499044;2225.7551669316445;2234.1845226492214;2234.597772400967;2234.9776502235013;2243.5512897420417;2270.8637481750984;2285.42864283929;2288.656701494789;2291.9541609167723;8432.325413966868;8478.915210847874;8480.915190848074;8498.957505212435;8537.957310213409;4994.325766021577;5127.410347810012;5143.614228932845;5147.897042059138;5155.7679904404395;3303.405387030358;3331.6335203127637;3410.6077801052948;3422.828858557087;3442.6729460701195;1158.5018442069907;1162.6918866500384;1163.0288708928056;1183.4142099660723;1214.089432925306;11499.885001149965;11518.136139789549;11525.308481491054;11533.365664888428;11594.188406811527;4235.131797981407;4557.225271703752;4565.360849481075;4575.267957126844;4690.437147542317;9769.706908792748;9782.804343913082;9804.068613481708;9859.654912078044;9874.259430542594;5127.282180494733;5141.331626888481;5159.17453207485;5161.096808058574;5189.974050129726;4025.3961905714377;4732.976335118371;4733.053389322149;4752.477227505041;4775.06886157196;3906.980465097713;3918.2163567286657;4057.0668746188544;4058.2086493134148;4063.329550624173;1257.1451413039222;1272.179444258448;1283.595667364777;1287.0925997171971;1296.1704509114174;965.9565319560637;985.556499575194;991.3605724307926;994.8905620381752;1023.9744006399751;5973.611715238496;5981.581289309794;6001.969990150022;6003.789867354709;6152.938470615237;455.6218338778806;457.80543269110495;459.0474764862923;461.5661278398295;461.7114303560275;4017.6986725995084;4235.449391579075;4256.3189889617515;4261.509926358446;4275.422817919603;9983.450910200008;10437;10585.04734573892;10593.57625694979;10614.681559553226;9867.40795552269;10355.896441035493;10361.378317300987;10508.054275115277;10522.894771052344;7345.338919497271;7398.260173982559;7455.142658594223;7458.067741532309;7469.514481558681;5489.478499542537;5607.074832652566;5615.775368985195;5672.404397538199;5700.515456186271;9113.134252246025;9192.95403522978;9208.447493150432;9234.861477077715;9329.626814927327;9301.348905576544;9320.067993200626;9551.14039736427;9622.085901839315;9698.466584337646;7129.572225666477;7265.418766498562;7320.670569824264;7350.08123984502;7508.249175082448;7882.566458844819;7885.763427097197;7926.405519586169;7929.167437418988;7930.762077137695;7060.7881763547175;7147.606881621561;7247.8550428990075;7261.5280006799385;7351.301626345488;7221.4222862169845;7262.455315851226;7325.047743793486;7380.77857664271;7448.851022979402;6715;6792.422644075309;6828.248892621907;6874.072000279898;6875.724971001304;5015.498450154955;5027.899442011212;5057.69653820772;5100.285959965682;5166.922496162636;5014.34813474246;5039.496050394931;5100.6429549931145;5199.090159222196;5232.215167724872 06:09:46 INFO - PROCESS | 26500 | |4;prototype.html;323.9676032396759;332.7190317278477;337.8142021887961;338.84074484992044;342.0627480702874;5954.970225148868;5962.34414214436;6074.483668888144;6205.23150901993;6212.844678883031;5998.670073145975;6022.8795424091495;6040.758369665219;6049.274087109542;6065.878682426349;4632.351470794091;4666.183417901871;4672.462666793328;4673.462551806535;4678.4619768726525;4435.9334609980715;4666.556677115668;4693.577578017977;4696.976515117437;4712.222483290253;4586.4266966629175;4588.449386073659;4608.308753686941;4632.837850675227;4647.790849411767;4609.262517997138;4627.167109920213;4627.444706635225;4646.25659894417;4652.860414187579;4004.759714417144;4064.715469917107;4081.6326530612387;4082.7346222495444;4105.630493255621;5790.739416726257;5845.181674565564;5846.9707651461895;5850.210221620069;5862.794802181946;5336.599755018389;5342.332208473941;5348.839534813962;5349.277847490578;5362.812301569426;6164.6917654117115;6363.96818015907;6375.968120159369;6389.36106389362;6395.3284905084765;4476.7761611919595;4491;4494.1910456117885;4499.145162419162;4538.546145385468;6441.613503189777;6635.900461493082;6667.699953502104;6687;6708.798736037927;4534;4579.977100114478;4594.448666160082;4598.057398233354;4609.8847528811375;4648.6745927785405;4656.208444564432;4667.789949452215;4673.789679464432;4678.0410015946645;5191.169412893919;5320.680759154463;5322.946770532322;5340.092184328673;5347.893042139135;6039.4262545058145;6232.3144454110015;6389.936100639027;6402.727031903607;6448.032795080775;1617.5875151836206;1628.2510045379022;1631.4126914310839;1634.4197809777595;1637.2386840119402;1069.9518521666544;1094.409019129677;1097.3306283167262;1102.8676558812833;1117.6423544465856;6089.543284253698;6100.938990610126;6120.908186377208;6134.294556126102;6184.8763024739255;6497.545171837926;6542.509311801538;6594.7032383542855;6607.108040414579;6659.700313485905;6003.909941350883;6197.752089916353;6244.937550624527;6254.593451425642;6257.843553911189;3550.343186510504;3558.5373901393173;3565.982170089133;3571.39286321326;3573.446115852047;6586.868262634816;6798.082258894986;6833.282505336968;6843.452523798084;6887.655617219119;6732.865342693119;6740.573393578308;6768.153980752406;6773.288804675537;6790.151231096113;6625.403713665697;6856.965715171492;6863.416609588241;6866.759663411756;6869.828254293682;6408.871822563616;6497.220333560003;6562.77030303937;6579.572327798678;6607.456129390123;6298.984325016134;6363.5863668861375;6431.774887878902;6439.388258115471;6499.5125365598715;6781.47416831209;6786.830329241809;6805.149356330458;6825.215100263533;6853.554518956252;4603.516630753723;4607.424071991001;4615.515370886009;4630.6758526902795;4635.814567417266;6477.578957367756;6485.643289618927;6576.605403675603;6579.539432239697;6755.324467553205;6440.645764482999;6489.286178520265;6511.218653761579;6524.445422139172;6539.280679125197;6330.936690633035;6427.6786160690845;6435.163428754232;6455.838604034937;6486.416222539994;6321.008882202092;6361.904571431525;6371.426571608577;6377.553571249968;6390.137331460193;6478.287388387368;6479.773207937699;6480.773172938924;6544.640044797582;6562.606243625398;6185.226846644169;6272.874542509216;6404.391582799627;6415.133956915944;6422.357764223727 06:09:46 INFO - PROCESS | 26500 | |5;yui.html;736.3777607921305;779.8518281526506;816.3020617372146;827.2554700769309;843.7384410832642;14469.276536173189;14602.926985365084;14730.63173420665;14740.852591474082;14772.335244913991;12321.137520373577;13512.662183445418;13546;13594;13601.795973060413;765.2577000309691;803.8111043904678;804.1235053791366;805.1545876829335;805.5810978291285;796.5300472721093;800.7357572001225;802.626778547975;802.7591722483261;804.8953636027309;836.113719457374;837.4933165434885;838.7861095420659;838.7903024243939;839.7858546070744;823.2878560045577;830.4933990265932;833.1335411172373;834.7954751085962;835.381817455085;606.8240210338996;607.1803065861096;610.0940103945637;612.3417326374166;612.583443258584;12719;12735.617931462071;12742.872571274262;12758.936205318914;12790;13625.18248905059;13813.102148360324;13837.930810345884;13857.514986975508;13958.93020534901;12260.754784904251;12315.261084334968;12371.319577423239;12479.50081996719;12531.06017048725;4606.424196975378;4608.5621865922685;4641.559051890065;4748.572628463455;4764.904701905977;57104.428955710326;57830.42169578293;58033.41966580322;59272.70363648154;59666.70166649139;11305.265157764883;11453.59912403062;11472.54109835614;11477.139214558942;11498;20269.797302027087;20325.390238292875;20426.897865510873;20457.48856278605;20775.168993240102;8384.748457546284;8462.746117616482;8494.53280069602;8511.574421279036;8545.230929216275;4501.707389019703;4621.12198682256;4682.204025315705;4705.4588722296685;4782.856514304576;3250.593675790526;3340.9643010666773;3342.097633638904;3344.1973926257524;3346.966530334714;637.445422482434;651.46905272203;654.5352799512305;654.6922946215367;655.8917778566579;613.5214532664529;632.7923074637818;682.1507223506766;693.389816961071;701.9859602808017;8961.538652981792;9158.771030724285;9169.495677737788;9235.1688348049;9434.433933963985;597.4682532546037;616.2266355723627;619.3187493756922;644.291279592454;687.1376422589718;4124.257633625976;4149.5382782245815;4188.183304255702;4282.657387409;4295.22685916538;57516.42483575111;57544.136837947466;58009.70995144997;58078.41921580815;60107.39892601018;52124.739376302874;56262.718686406304;57993.71003145041;59095.70452147712;59155.40844591499;53150.46849531533;53153.7342313286;53779.999999999214;54240.45759542354;54427.72786136044;8856.601452934505;9085.772855678397;9133.132352426508;9184.448933064037;9313.674021409219;34649.48025779565;34664.480032800035;34854.12864678302;35031.82484087563;35122.297554049284;39991.40012899867;41267.38098928578;44825.77587112174;45204.321935171654;45714;12280.631581052583;12358.50565977351;12493.125481216592;12515.436805343963;12695.36523173856;13298.534551290659;13719.1082579636;13795.034347595572;13925.164490130624;14177.858221417653;13271.137376070525;13331.866681333451;13617.591472255848;13771.242581658105;13966.371513281723;12933;12966.546170883974;13226.735465290449;13687.247201404018;13725.725485490433;12988.67528311762;13338.666533336744;13526.526571569948;13606.659833504242;13733.862661373258;10140.087392134743;10173.13528350069;10361.326513776581;10597.046265836112;10685.305455145392;10738.463076846283;11086.501107450345;11164.609238676607;11345.432728363383;11468.4265786712 06:09:46 INFO - PROCESS | 26500 | __end_tp_report 06:09:46 INFO - PROCESS | 26500 | __start_cc_report 06:09:46 INFO - PROCESS | 26500 | _x_x_mozilla_cycle_collect,333 06:09:46 INFO - PROCESS | 26500 | __end_cc_report 06:09:46 INFO - PROCESS | 26500 | __startTimestamp1461071386548__endTimestamp 06:09:46 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | ------- Summary: start ------- 06:09:46 INFO - PROCESS | 26500 | Number of tests: 6 06:09:46 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | [#0] dojo.html Cycles:165 Average:5490.98 Median:5745.60 stddev:725.07 (12.6%) stddev-sans-first:703.82 06:09:46 INFO - PROCESS | 26500 | Values: 3158.6 3225.2 3238.4 3281.2 3282.7 5541.3 5566.3 5583.5 5588.4 5592.9 5445.1 5536.4 5565.8 5636.4 5650.5 5010.1 5019.1 5085.9 5093.0 5139.3 833.6 5014.3 5096.7 5104.8 5166.5 5086.6 5088.1 5093.5 5104.4 5129.0 4920.3 5183.1 5189.5 5189.6 5193.6 4968.3 5011.3 5014.1 5026.3 5046.6 5409.5 5429.6 5431.1 5447.9 5449.1 5881.4 5899.7 5909.6 5934.6 5985.2 5947.1 5955.6 5971.7 5985.6 6019.9 5460.7 5502.3 5541.2 5557.4 5561.2 5938.7 6069.5 6093.3 6098.2 6107.1 5698.6 5723.3 5736.8 5752.0 5763.0 5838.1 5903.2 5904.5 5907.5 5912.5 5781.0 5955.4 5993.6 6006.0 6063.8 5803.6 5889.8 5908.6 5936.1 6011.2 4480.7 4484.7 4490.4 4498.3 4526.5 3902.4 3986.9 3992.8 4035.1 4081.8 5678.8 5680.6 5691.4 5702.9 5713.1 5941.9 5967.7 5997.4 6013.1 6022.5 5483.6 5637.4 5726.9 5745.6 5746.2 5075.7 5096.0 5097.6 5098.8 5114.2 6129.4 6142.3 6145.8 6158.1 6159.8 5831.9 5899.3 5943.1 5973.6 5997.0 6157.0 6167.8 6175.5 6180.5 6181.1 5632.9 5869.6 5902.4 5905.2 5917.4 5916.4 5935.9 5937.5 5968.4 5984.9 5750.1 5792.1 5797.6 5831.2 5834.7 5584.1 5812.5 5818.9 5827.9 5830.4 5529.7 5714.1 5741.1 5796.1 5827.1 5828.5 5874.4 5875.0 5893.5 5903.4 5560.8 5602.3 5758.3 5759.7 5769.2 06:09:46 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | [#1] ext.html Cycles:180 Average:54151.52 Median:222693.30 stddev:104337.51 (46.9%) stddev-sans-first:104552.74 06:09:46 INFO - PROCESS | 26500 | Values: 599.8 644.7 656.4 658.8 662.9 37142.4 37296.0 37726.0 37754.8 38068.2 40644.0 40997.6 41086.8 41104.6 41550.2 8521.2 8833.1 8847.7 8849.8 8850.5 8717.3 8804.1 8822.1 8835.0 8877.6 8959.6 9032.8 9052.0 9054.6 9066.7 8949.1 8954.0 8995.7 9028.5 9072.7 8821.2 8913.4 8916.6 8922.6 8957.1 39842.6 39878.4 40107.2 40113.8 40259.4 3388.9 3521.1 3542.8 3544.5 3886.2 28277.9 28328.2 28442.4 28564.0 29266.9 4131.3 4176.3 4220.7 4307.9 4319.5 263532.0 264850.0 267708.0 271024.0 271044.0 35489.3 36349.6 56268.7 57675.7 57799.7 34080.3 34118.7 34156.5 34157.1 34173.8 14561.2 14988.9 14994.7 14994.7 15001.6 12233.3 12426.6 12473.7 12480.9 12502.6 8529.8 8541.3 8554.4 8605.0 8651.8 3324.9 3381.4 3390.5 3392.9 3400.3 1083.2 1088.7 1156.5 1183.2 1224.3 31405.8 31848.5 32192.8 32348.0 32450.8 1126.4 1148.8 1216.5 1230.0 1235.6 16590.5 16827.2 16840.1 17123.6 17136.6 474572.0 478771.0 480474.0 480959.0 481820.0 56766.7 57117.7 57788.3 57859.4 58022.0 1351.8 1395.9 1397.2 1412.7 1413.0 30047.2 30267.0 31778.5 32469.7 35213.6 54809.0 55922.7 55964.2 56148.7 56152.4 397396.0 405027.0 406510.0 406943.0 407300.0 43090.6 43357.3 43824.3 43880.6 44114.0 47485.3 47964.3 48618.3 48949.3 49453.0 40073.8 40359.6 41407.8 42178.6 42289.6 40141.0 40514.6 41111.8 41276.8 42198.0 41732.2 42409.0 42608.4 43020.4 43033.6 33152.7 35591.8 35884.8 35937.5 36018.5 24579.6 25240.0 25282.9 25285.2 25455.7 06:09:46 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | [#2] jquery.html Cycles:180 Average:26096.44 Median:37019.22 stddev:71118.58 (192.1%) stddev-sans-first:71291.89 06:09:46 INFO - PROCESS | 26500 | Values: 387.9 400.8 401.7 406.2 411.6 13526.5 17698.6 18048.6 18339.4 18422.4 16377.5 16482.3 16493.3 16709.2 17376.1 5179.5 5681.7 5825.8 5857.5 5875.1 6429.4 6436.0 6470.7 6470.9 6471.4 5189.8 5515.8 5518.0 6407.4 6438.8 5339.8 5409.2 5421.9 5435.9 5827.4 5245.6 5453.2 5483.2 5518.1 5520.6 11911.0 12553.0 12660.6 12671.6 21107.2 2188.1 2281.8 2363.5 2605.8 2830.4 9270.1 9929.1 12299.4 13523.0 13736.2 1757.9 1871.8 1878.9 1887.7 1947.5 70166.6 72447.6 72628.3 74274.0 74361.0 9750.7 9777.6 9865.7 10026.3 10159.6 13285.7 13391.0 13428.5 13435.3 13468.6 7557.5 7630.8 7679.9 7707.0 7895.2 7408.0 7627.9 7633.8 7697.3 7746.1 4065.7 4087.7 4123.5 4185.5 4213.7 1734.2 1775.7 1799.7 1814.8 1819.9 1008.3 1041.1 1045.5 1064.3 1118.9 17546.5 17736.4 17831.3 17984.8 18114.6 1000.0 1032.0 1033.7 1047.7 1103.9 9412.0 9569.9 9610.6 9835.3 10130.1 412588.0 427715.0 434825.0 435062.0 438684.0 89312.0 92130.0 92130.0 92830.0 92872.0 1036.0 1058.4 1075.1 1092.5 1094.5 15306.5 15321.1 15327.8 15522.1 15838.4 35258.3 36212.5 36322.5 36707.8 37330.6 49980.5 51040.0 53515.0 54743.7 54947.5 8035.0 8118.5 8283.3 8555.8 8603.4 7203.9 10997.7 12126.8 12178.7 12511.7 11636.2 11645.4 11697.5 11713.1 11755.4 11020.8 11102.0 11151.8 11181.7 11255.2 5936.2 9831.5 10581.6 11640.2 11784.9 7252.6 7515.8 8283.8 8513.9 8531.0 11038.9 11526.3 11648.7 11689.0 11815.5 06:09:46 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | [#3] mootools.html Cycles:180 Average:5545.47 Median:5100.46 stddev:3069.29 (60.2%) stddev-sans-first:3062.82 06:09:46 INFO - PROCESS | 26500 | Values: 1495.9 1541.7 1670.2 1788.0 1811.1 7607.8 8098.8 8242.7 8438.8 8453.8 8235.3 8261.1 8309.5 8364.6 8372.1 2286.8 2291.4 2302.4 2322.7 2325.1 2269.1 2284.6 2322.7 2323.4 2325.1 2313.5 2314.4 2331.4 2333.8 2337.8 2218.0 2225.8 2234.2 2234.6 2235.0 2243.6 2270.9 2285.4 2288.7 2292.0 8432.3 8478.9 8480.9 8499.0 8538.0 4994.3 5127.4 5143.6 5147.9 5155.8 3303.4 3331.6 3410.6 3422.8 3442.7 1158.5 1162.7 1163.0 1183.4 1214.1 11499.9 11518.1 11525.3 11533.4 11594.2 4235.1 4557.2 4565.4 4575.3 4690.4 9769.7 9782.8 9804.1 9859.7 9874.3 5127.3 5141.3 5159.2 5161.1 5190.0 4025.4 4733.0 4733.1 4752.5 4775.1 3907.0 3918.2 4057.1 4058.2 4063.3 1257.1 1272.2 1283.6 1287.1 1296.2 966.0 985.6 991.4 994.9 1024.0 5973.6 5981.6 6002.0 6003.8 6152.9 455.6 457.8 459.0 461.6 461.7 4017.7 4235.4 4256.3 4261.5 4275.4 9983.5 10437.0 10585.0 10593.6 10614.7 9867.4 10355.9 10361.4 10508.1 10522.9 7345.3 7398.3 7455.1 7458.1 7469.5 5489.5 5607.1 5615.8 5672.4 5700.5 9113.1 9193.0 9208.4 9234.9 9329.6 9301.3 9320.1 9551.1 9622.1 9698.5 7129.6 7265.4 7320.7 7350.1 7508.2 7882.6 7885.8 7926.4 7929.2 7930.8 7060.8 7147.6 7247.9 7261.5 7351.3 7221.4 7262.5 7325.0 7380.8 7448.9 6715.0 6792.4 6828.2 6874.1 6875.7 5015.5 5027.9 5057.7 5100.3 5166.9 5014.3 5039.5 5100.6 5199.1 5232.2 06:09:46 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | [#4] prototype.html Cycles:180 Average:5367.20 Median:6095.24 stddev:1604.62 (26.3%) stddev-sans-first:1563.84 06:09:46 INFO - PROCESS | 26500 | Values: 324.0 332.7 337.8 338.8 342.1 5955.0 5962.3 6074.5 6205.2 6212.8 5998.7 6022.9 6040.8 6049.3 6065.9 4632.4 4666.2 4672.5 4673.5 4678.5 4435.9 4666.6 4693.6 4697.0 4712.2 4586.4 4588.4 4608.3 4632.8 4647.8 4609.3 4627.2 4627.4 4646.3 4652.9 4004.8 4064.7 4081.6 4082.7 4105.6 5790.7 5845.2 5847.0 5850.2 5862.8 5336.6 5342.3 5348.8 5349.3 5362.8 6164.7 6364.0 6376.0 6389.4 6395.3 4476.8 4491.0 4494.2 4499.1 4538.5 6441.6 6635.9 6667.7 6687.0 6708.8 4534.0 4580.0 4594.4 4598.1 4609.9 4648.7 4656.2 4667.8 4673.8 4678.0 5191.2 5320.7 5322.9 5340.1 5347.9 6039.4 6232.3 6389.9 6402.7 6448.0 1617.6 1628.3 1631.4 1634.4 1637.2 1070.0 1094.4 1097.3 1102.9 1117.6 6089.5 6100.9 6120.9 6134.3 6184.9 6497.5 6542.5 6594.7 6607.1 6659.7 6003.9 6197.8 6244.9 6254.6 6257.8 3550.3 3558.5 3566.0 3571.4 3573.4 6586.9 6798.1 6833.3 6843.5 6887.7 6732.9 6740.6 6768.2 6773.3 6790.2 6625.4 6857.0 6863.4 6866.8 6869.8 6408.9 6497.2 6562.8 6579.6 6607.5 6299.0 6363.6 6431.8 6439.4 6499.5 6781.5 6786.8 6805.1 6825.2 6853.6 4603.5 4607.4 4615.5 4630.7 4635.8 6477.6 6485.6 6576.6 6579.5 6755.3 6440.6 6489.3 6511.2 6524.4 6539.3 6330.9 6427.7 6435.2 6455.8 6486.4 6321.0 6361.9 6371.4 6377.6 6390.1 6478.3 6479.8 6480.8 6544.6 6562.6 6185.2 6272.9 6404.4 6415.1 6422.4 06:09:46 INFO - PROCESS | 26500 | 06:09:46 INFO - PROCESS | 26500 | [#5] yui.html Cycles:180 Average:15078.49 Median:25160.21 stddev:17325.63 (68.9%) stddev-sans-first:17340.76 06:09:46 INFO - PROCESS | 26500 | Values: 736.4 779.9 816.3 827.3 843.7 14469.3 14602.9 14730.6 14740.9 14772.3 12321.1 13512.7 13546.0 13594.0 13601.8 765.3 803.8 804.1 805.2 805.6 796.5 800.7 802.6 802.8 804.9 836.1 837.5 838.8 838.8 839.8 823.3 830.5 833.1 834.8 835.4 606.8 607.2 610.1 612.3 612.6 12719.0 12735.6 12742.9 12758.9 12790.0 13625.2 13813.1 13837.9 13857.5 13958.9 12260.8 12315.3 12371.3 12479.5 12531.1 4606.4 4608.6 4641.6 4748.6 4764.9 57104.4 57830.4 58033.4 59272.7 59666.7 11305.3 11453.6 11472.5 11477.1 11498.0 20269.8 20325.4 20426.9 20457.5 20775.2 8384.7 8462.7 8494.5 8511.6 8545.2 4501.7 4621.1 4682.2 4705.5 4782.9 3250.6 3341.0 3342.1 3344.2 3347.0 637.4 651.5 654.5 654.7 655.9 613.5 632.8 682.2 693.4 702.0 8961.5 9158.8 9169.5 9235.2 9434.4 597.5 616.2 619.3 644.3 687.1 4124.3 4149.5 4188.2 4282.7 4295.2 57516.4 57544.1 58009.7 58078.4 60107.4 52124.7 56262.7 57993.7 59095.7 59155.4 53150.5 53153.7 53780.0 54240.5 54427.7 8856.6 9085.8 9133.1 9184.4 9313.7 34649.5 34664.5 34854.1 35031.8 35122.3 39991.4 41267.4 44825.8 45204.3 45714.0 12280.6 12358.5 12493.1 12515.4 12695.4 13298.5 13719.1 13795.0 13925.2 14177.9 13271.1 13331.9 13617.6 13771.2 13966.4 12933.0 12966.5 13226.7 13687.2 13725.7 12988.7 13338.7 13526.5 13606.7 13733.9 10140.1 10173.1 10361.3 10597.0 10685.3 10738.5 11086.5 11164.6 11345.4 11468.4 06:09:46 INFO - PROCESS | 26500 | -------- Summary: end -------- 06:09:46 INFO - PROCESS | 26500 | 06:09:47 INFO - TEST-INFO | 26500: exit 0 06:09:47 INFO - TEST-OK | dromaeo_css | took 1110142ms 06:09:47 INFO - TEST-START | kraken 06:09:47 INFO - operating with platform_type : linux_ 06:09:47 INFO - Initialising browser for kraken test... 06:09:47 INFO - TEST-INFO | started process 26733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSLLYOo/profile http://localhost:56344/getInfo.html) 06:09:50 INFO - PROCESS | 26733 | 06:09:50 INFO - PROCESS | 26733 | (process:26805): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:09:51 INFO - PROCESS | 26733 | __metrics Screen width/height:1600/1200 06:09:51 INFO - PROCESS | 26733 | colorDepth:24 06:09:51 INFO - PROCESS | 26733 | Browser inner width/height: 1024/697 06:09:51 INFO - PROCESS | 26733 | __metrics 06:09:52 ERROR - PROCESS | 26733 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:09:53 INFO - TEST-INFO | 26733: exit 0 06:09:53 INFO - Browser initialized. 06:09:53 INFO - Running cycle 1/1 for kraken test... 06:09:53 INFO - TEST-INFO | started process 26856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSLLYOo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:55 INFO - PROCESS | 26856 | 06:09:55 INFO - PROCESS | 26856 | (process:26916): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:10:05 INFO - PROCESS | 26856 | RSS: Main: 164040704 06:10:05 INFO - PROCESS | 26856 | 06:10:07 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56344/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:08 INFO - PROCESS | 26856 | RSS: Main: 168333312 06:10:08 INFO - PROCESS | 26856 | 06:10:11 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56344/tests/kraken/driver.html?testName=audio-dft) 06:10:11 INFO - PROCESS | 26856 | RSS: Main: 171773952 06:10:11 INFO - PROCESS | 26856 | 06:10:14 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56344/tests/kraken/driver.html?testName=audio-fft) 06:10:15 INFO - PROCESS | 26856 | RSS: Main: 164147200 06:10:15 INFO - PROCESS | 26856 | 06:10:17 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56344/tests/kraken/driver.html?testName=audio-oscillator) 06:10:18 INFO - PROCESS | 26856 | RSS: Main: 164487168 06:10:18 INFO - PROCESS | 26856 | 06:10:20 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56344/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:20 INFO - PROCESS | 26856 | RSS: Main: 164462592 06:10:20 INFO - PROCESS | 26856 | 06:10:24 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56344/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:24 INFO - PROCESS | 26856 | RSS: Main: 165384192 06:10:24 INFO - PROCESS | 26856 | 06:10:28 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56344/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:28 INFO - PROCESS | 26856 | RSS: Main: 162295808 06:10:28 INFO - PROCESS | 26856 | 06:10:31 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56344/tests/kraken/driver.html?testName=json-parse-financial) 06:10:32 INFO - PROCESS | 26856 | RSS: Main: 163078144 06:10:32 INFO - PROCESS | 26856 | 06:10:33 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56344/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:34 INFO - PROCESS | 26856 | RSS: Main: 163188736 06:10:34 INFO - PROCESS | 26856 | 06:10:36 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56344/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:36 INFO - PROCESS | 26856 | RSS: Main: 163155968 06:10:36 INFO - PROCESS | 26856 | 06:10:38 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56344/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:39 INFO - PROCESS | 26856 | RSS: Main: 163823616 06:10:39 INFO - PROCESS | 26856 | 06:10:42 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:42 INFO - PROCESS | 26856 | RSS: Main: 164470784 06:10:42 INFO - PROCESS | 26856 | 06:10:45 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:46 INFO - PROCESS | 26856 | RSS: Main: 165019648 06:10:46 INFO - PROCESS | 26856 | 06:10:47 INFO - PROCESS | 26856 | Cycle 1(1): loaded http://localhost:56344/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56344/tests/kraken/driver.html?testName=ai-astar) 06:10:48 INFO - PROCESS | 26856 | RSS: Main: 165756928 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | __start_tp_report 06:10:48 INFO - PROCESS | 26856 | _x_x_mozilla_page_load 06:10:48 INFO - PROCESS | 26856 | _x_x_mozilla_page_load_details 06:10:48 INFO - PROCESS | 26856 | |i|pagename|runs| 06:10:48 INFO - PROCESS | 26856 | |0;ai-astar;111;105;112;113;109;124;111;111;110;114 06:10:48 INFO - PROCESS | 26856 | |1;audio-beat-detection;162;134;164;184;128;156;158;129;184;138 06:10:48 INFO - PROCESS | 26856 | |2;audio-dft;163;164;163;162;163;164;175;162;164;164 06:10:48 INFO - PROCESS | 26856 | |3;audio-fft;74;75;74;171;75;74;77;73;164;77 06:10:48 INFO - PROCESS | 26856 | |4;audio-oscillator;93;94;157;93;92;93;144;92;93;144 06:10:48 INFO - PROCESS | 26856 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;118;118;118 06:10:48 INFO - PROCESS | 26856 | |6;imaging-darkroom;146;148;147;147;151;147;147;147;147;147 06:10:48 INFO - PROCESS | 26856 | |7;imaging-desaturate;97;96;94;95;95;97;96;95;95;95 06:10:48 INFO - PROCESS | 26856 | |8;json-parse-financial;59;56;56;58;58;56;57;69;55;54 06:10:48 INFO - PROCESS | 26856 | |9;json-stringify-tinderbox;60;61;61;62;61;60;60;61;61;60 06:10:48 INFO - PROCESS | 26856 | |10;stanford-crypto-aes;77;79;77;77;77;78;79;80;81;78 06:10:48 INFO - PROCESS | 26856 | |11;stanford-crypto-ccm;130;128;138;132;139;127;128;127;158;129 06:10:48 INFO - PROCESS | 26856 | |12;stanford-crypto-pbkdf2;176;170;171;170;167;182;168;168;176;174 06:10:48 INFO - PROCESS | 26856 | |13;stanford-crypto-sha256-iterative;75;70;69;68;70;69;68;68;67;69 06:10:48 INFO - PROCESS | 26856 | __end_tp_report 06:10:48 INFO - PROCESS | 26856 | __start_cc_report 06:10:48 INFO - PROCESS | 26856 | _x_x_mozilla_cycle_collect,857 06:10:48 INFO - PROCESS | 26856 | __end_cc_report 06:10:48 INFO - PROCESS | 26856 | __startTimestamp1461071448121__endTimestamp 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | ------- Summary: start ------- 06:10:48 INFO - PROCESS | 26856 | Number of tests: 14 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:4.88 (4.4%) stddev-sans-first:5.16 06:10:48 INFO - PROCESS | 26856 | Values: 111.0 105.0 112.0 113.0 109.0 124.0 111.0 111.0 110.0 114.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:160.00 stddev:20.92 (13.1%) stddev-sans-first:21.98 06:10:48 INFO - PROCESS | 26856 | Values: 162.0 134.0 164.0 184.0 128.0 156.0 158.0 129.0 184.0 138.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.81 (2.3%) stddev-sans-first:4.00 06:10:48 INFO - PROCESS | 26856 | Values: 163.0 164.0 163.0 162.0 163.0 164.0 175.0 162.0 164.0 164.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#3] audio-fft Cycles:10 Average:93.40 Median:74.50 stddev:39.11 (52.5%) stddev-sans-first:40.85 06:10:48 INFO - PROCESS | 26856 | Values: 74.0 75.0 74.0 171.0 75.0 74.0 77.0 73.0 164.0 77.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:93.00 stddev:27.04 (29.1%) stddev-sans-first:28.01 06:10:48 INFO - PROCESS | 26856 | Values: 93.0 94.0 157.0 93.0 92.0 93.0 144.0 92.0 93.0 144.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:10:48 INFO - PROCESS | 26856 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.33 06:10:48 INFO - PROCESS | 26856 | Values: 146.0 148.0 147.0 147.0 151.0 147.0 147.0 147.0 147.0 147.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:0.87 06:10:48 INFO - PROCESS | 26856 | Values: 97.0 96.0 94.0 95.0 95.0 97.0 96.0 95.0 95.0 95.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:4.21 (7.3%) stddev-sans-first:4.44 06:10:48 INFO - PROCESS | 26856 | Values: 59.0 56.0 56.0 58.0 58.0 56.0 57.0 69.0 55.0 54.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 06:10:48 INFO - PROCESS | 26856 | Values: 60.0 61.0 61.0 62.0 61.0 60.0 60.0 61.0 61.0 60.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:1.42 (1.8%) stddev-sans-first:1.42 06:10:48 INFO - PROCESS | 26856 | Values: 77.0 79.0 77.0 77.0 77.0 78.0 79.0 80.0 81.0 78.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#11] stanford-crypto-ccm Cycles:10 Average:133.60 Median:131.00 stddev:9.61 (7.3%) stddev-sans-first:10.10 06:10:48 INFO - PROCESS | 26856 | Values: 130.0 128.0 138.0 132.0 139.0 127.0 128.0 127.0 158.0 129.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.50 stddev:4.73 (2.7%) stddev-sans-first:4.82 06:10:48 INFO - PROCESS | 26856 | Values: 176.0 170.0 171.0 170.0 167.0 182.0 168.0 168.0 176.0 174.0 06:10:48 INFO - PROCESS | 26856 | 06:10:48 INFO - PROCESS | 26856 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.21 (3.2%) stddev-sans-first:1.00 06:10:48 INFO - PROCESS | 26856 | Values: 75.0 70.0 69.0 68.0 70.0 69.0 68.0 68.0 67.0 69.0 06:10:48 INFO - PROCESS | 26856 | -------- Summary: end -------- 06:10:48 INFO - PROCESS | 26856 | 06:10:49 INFO - TEST-INFO | 26856: exit 0 06:10:49 INFO - TEST-OK | kraken | took 61855ms 06:10:49 INFO - SUITE-END | took 1171s 06:10:49 INFO - Completed test suite (00:19:32) 06:10:49 INFO - javascript benchmark 06:10:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.58938338016, 3225.225945773015, 3238.3685181389637, 3281.228911205866, 3282.688144626261, 5541.307336582932, 5566.27638407007, 5583.497485226334, 5588.441155884409, 5592.944070559293, 5445.101558242885, 5536.363318218406, 5565.833025009246, 5636.436356364362, 5650.5479561635075, 5010.098182327189, 5019.121653710605, 5085.923711144335, 5093.0, 5139.280500729901, 833.5539260344074, 5014.272930425086, 5096.745162741867, 5104.846854594368, 5166.509181627758, 5086.618503612225, 5088.135017047092, 5093.516115969014, 5104.387473503166, 5128.999845030239, 4920.286558449041, 5183.118869792107, 5189.481051894818, 5189.584833213372, 5193.63644544882, 4968.279599458095, 5011.32347133136, 5014.097462456756, 5026.29631851541, 5046.571041461443, 5409.540189083893, 5429.56563474925, 5431.076716958127, 5447.891042179134, 5449.128139497661, 5881.353051164411, 5899.705014749288, 5909.645421274738, 5934.5845790794665, 5985.221921150266, 5947.078202878518, 5955.612885162451, 5971.671558064305, 5985.5810093293485, 6019.879602407971, 5460.744028873341, 5502.257195278627, 5541.196526503675, 5557.416471270499, 5561.221428999943, 5938.703064846741, 6069.544784141207, 6093.268807743099, 6098.159935307505, 6107.053406721965, 5698.629589076697, 5723.341815691166, 5736.77052917887, 5751.971240143856, 5762.971185144132, 5838.1242813577455, 5903.203067585821, 5904.4685978261305, 5907.527397808165, 5912.467877890925, 5780.988327042751, 5955.374685657944, 5993.61041532299, 6006.0, 6063.818085457443, 5803.564732645069, 5889.793857215062, 5908.615939963975, 5936.079907614327, 6011.1884895539415, 4480.708753930984, 4484.708493947883, 4490.39379683745, 4498.280275155959, 4526.547345265513, 3902.35611124167, 3986.9202615948097, 3992.84028638857, 4035.051762835731, 4081.77550234734, 5678.829635110953, 5680.630759000652, 5691.402402747734, 5702.914456283159, 5713.143028545668, 5941.851453713692, 5967.671778052249, 5997.400259974055, 6013.067974463965, 6022.45797878193, 5483.616146869761, 5637.379888212294, 5726.885462290814, 5745.597808153473, 5746.166805813217, 5075.746212689424, 5096.031753966735, 5097.592192624581, 5098.770555325019, 5114.207297868837, 6129.35641757609, 6142.32434432221, 6145.754169833246, 6158.137860699506, 6159.753609855556, 5831.88336233273, 5899.321578018411, 5943.138244954544, 5973.5519836013345, 5997.0, 6157.0456579230295, 6167.753289868355, 6175.536834737323, 6180.536459765625, 6181.103739957771, 5632.85917852057, 5869.589128760946, 5902.4097590240635, 5905.202797622266, 5917.408259174048, 5916.408359164049, 5935.881282374415, 5937.495312898279, 5968.432998865101, 5984.880302393841, 5750.0512415450985, 5792.073268277056, 5797.594168408171, 5831.241938547962, 5834.737436815439, 5584.134459158837, 5812.476877081083, 5818.854528636818, 5827.9417205829095, 5830.387809280134, 5529.695866727368, 5714.114312281603, 5741.081426971665, 5796.1305804129715, 5827.096799996008, 5828.504577110993, 5874.353821079592, 5875.030619947832, 5893.499052580579, 5903.380145084704, 5560.805371811967, 5602.2717046783655, 5758.2514273144225, 5759.65442073477, 5769.249997500298], "value": 5444.169394821759, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8230521996011, 644.6615526848404, 656.3928366261209, 658.8451713847245, 662.9436497897678, 37142.442863357035, 37296.0, 37726.0, 37754.8112259439, 38068.23863522728, 40644.0, 40997.59002409975, 41086.7945660272, 41104.58895411045, 41550.16899662005, 8521.233089021987, 8833.07252738463, 8847.690330838423, 8849.778755531132, 8850.468971861677, 8717.259032982203, 8804.075572064938, 8822.11778822119, 8834.955825220897, 8877.600507977124, 8959.552022398886, 9032.819343613124, 9052.04953479885, 9054.637814487412, 9066.682666106688, 8949.105089491031, 8954.0, 8995.685151019716, 9028.50343231122, 9072.682456114071, 8821.161989610977, 8913.420627659247, 8916.55417229136, 8922.643094276222, 8957.104289571056, 39842.60157398418, 39878.401823972665, 40107.197856042716, 40113.79943100295, 40259.39610905839, 3388.9322213555592, 3521.1197200699826, 3542.822858857047, 3544.468329750532, 3886.24218277436, 28277.858610707022, 28328.15015549537, 28442.431151376855, 28564.0, 29266.85366573175, 4131.29767939451, 4176.2900306947895, 4220.725652832556, 4307.935380969288, 4319.481662200525, 263532.0, 264850.0, 267708.0, 271024.0, 271043.999999998, 35489.29021419557, 36349.636503634625, 56268.718656406454, 57675.71162144246, 57799.711001444724, 34080.31839363199, 34118.658813411545, 34156.48765268523, 34157.14607134841, 34173.82913085468, 14561.199134047518, 14988.925055374653, 14994.70010599782, 14994.70010599782, 15001.624959376102, 12233.3271670059, 12426.62720118398, 12473.688157795947, 12480.937595312147, 12502.562410315777, 8529.829403411897, 8541.273991710774, 8554.401191916506, 8604.956975215084, 8651.826963460695, 3324.883629072971, 3381.3575420669995, 3390.4914262860766, 3392.9321413571593, 3400.2689421773944, 1083.2471432354596, 1088.678839742278, 1156.5084838943415, 1183.189515182103, 1224.3021477757593, 31405.842970785, 31848.522272165937, 32192.83903580514, 32348.029559113264, 32450.837745811594, 1126.4030064066058, 1148.7645032768262, 1216.519474807464, 1229.9877001229872, 1235.5860786636576, 16590.50228493147, 16827.24277407495, 16840.073795941094, 17123.571910702332, 17136.57158571046, 474572.0, 478771.0, 480474.0, 480959.0, 481820.0, 56766.71616641973, 57117.714411427674, 57788.26635200951, 57859.42140578625, 58022.0, 1351.7837146056584, 1395.874371306567, 1397.196611948134, 1412.7457057729707, 1413.0250127412053, 30047.248818779706, 30267.0, 31778.523322149726, 32469.675303246666, 35213.64786352104, 54809.0, 55922.72038639781, 55964.16053759278, 56148.719256403456, 56152.43847561472, 397396.0, 405027.0, 406510.0, 406943.0, 407300.0, 43090.56909430865, 43357.3496397548, 43824.34263486114, 43880.56119438765, 44114.0, 47485.287720683526, 47964.28053579269, 48618.27072593843, 48949.2657610129, 49453.0, 40073.79963100166, 40359.59640403676, 41407.792961035004, 42178.578214217465, 42289.57710422856, 40141.0, 40514.59485405108, 41111.7944410276, 41276.793616031726, 42198.0, 41732.1653566933, 42409.0, 42608.360874587524, 43020.35469468023, 43033.56966430296, 33152.66847331592, 35591.82204088963, 35884.820575896956, 35937.46093808542, 36018.45972310365, 24579.631305530787, 25240.0, 25282.87358563269, 25285.241442756746, 25455.74544254608], "value": 18727.757157405802, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.88363490952713, 400.82764411303145, 401.67464353873345, 406.2099217022888, 411.5760766410596, 13526.458941642348, 17698.646027079467, 18048.639027219448, 18339.44981650551, 18422.447326580208, 16377.508674739747, 16482.25829837657, 16493.34026638933, 16709.248083836224, 17376.131193440342, 5179.507946745053, 5681.715914204294, 5825.796097136601, 5857.502112320437, 5875.089361149007, 6429.35706429358, 6435.967820160892, 6470.676466176696, 6470.870582588345, 6471.352864713538, 5189.792408303663, 5515.751791169387, 5518.034343989806, 6407.359264073579, 6438.7746428875, 5339.759710813023, 5409.188621706736, 5421.9457805422035, 5435.864103397407, 5827.35899051104, 5245.554127899133, 5453.23654688344, 5483.2049352844015, 5518.061929471999, 5520.558355331604, 11911.0, 12553.0, 12660.55688050923, 12671.619851404472, 21107.15571377143, 2188.1102459522926, 2281.8174546036275, 2363.468219650582, 2605.830621009647, 2830.448062627788, 9270.072992700743, 9929.056739609725, 12299.446524906401, 13523.0, 13736.244506552135, 1757.850582700472, 1871.803460636627, 1878.8684792064562, 1887.7357169996212, 1947.5239474049558, 70166.64916675435, 72447.63776181138, 72628.2737172632, 74274.0, 74361.0, 9750.707478775648, 9777.608895644236, 9865.704028879145, 10026.298159128937, 10159.593616255266, 13285.667858303426, 13391.0, 13428.462861485432, 13435.261060641564, 13468.595942121752, 7557.508761930457, 7630.7710768677025, 7679.923200768033, 7706.961465192639, 7895.249951254622, 7408.03695519579, 7627.923720762721, 7633.770986870402, 7697.3072423481035, 7746.070471543451, 4065.6747460203114, 4087.693422993287, 4123.546409894909, 4185.476815398075, 4213.705040647186, 1734.2109340250408, 1775.698131317679, 1799.6850551153495, 1814.8185181481747, 1819.8635102367375, 1008.3294609085023, 1041.094248004226, 1045.513836066233, 1064.3209245295232, 1118.8769235384102, 17546.473605791845, 17736.379226727262, 17831.286748529914, 17984.820151798576, 18114.637707246045, 999.9950050199649, 1031.9690409287734, 1033.7002269341806, 1047.701405099543, 1103.9448027598587, 9412.0, 9569.904300957041, 9610.615575377047, 9835.3115281931, 10130.08829205375, 412588.0, 427715.0, 434825.0, 435062.0, 438684.0, 89312.0, 92130.0, 92130.01154924909, 92830.0, 92872.0, 1036.0106098675747, 1058.3808472043786, 1075.091547642241, 1092.5465931638282, 1094.4965315954591, 15306.540803775904, 15321.080735155927, 15327.846721532642, 15522.146281954601, 15838.445654402041, 35258.294834102664, 36212.456813148354, 36322.455163172046, 36707.81646091752, 37330.62669373272, 49980.50019499904, 51040.0, 53515.0, 54743.72628136834, 54947.450525494234, 8034.959825200836, 8118.472299300526, 8283.29591984664, 8555.82888342242, 8603.440776349516, 7203.927960720326, 10997.725056873642, 12126.75746485083, 12178.695532611755, 12511.687207819878, 11636.185467017227, 11645.359505227294, 11697.532098715956, 11713.121515886172, 11755.412229388667, 11020.779584408107, 11102.0, 11151.832722509007, 11181.664550063511, 11255.212135150789, 5936.1689363488285, 9831.525271209375, 10581.62964296246, 11640.185187036826, 11784.941075294568, 7252.5648461092505, 7515.812104697207, 8283.751487455385, 8513.914860851311, 8530.957345213234, 11038.889611103787, 11526.250793698382, 11648.650540483799, 11689.0, 11815.527378904748], "value": 8684.922321129088, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.8803295736338, 1541.6685412636282, 1670.2400407814446, 1788.01659087502, 1811.0854018720545, 7607.847843043136, 8098.757037288883, 8242.711505097323, 8438.789030274238, 8453.830923381529, 8235.299999500035, 8261.13258107899, 8309.459885107479, 8364.623591938362, 8372.120927302636, 2286.782755638216, 2291.4385975435957, 2302.4128847143957, 2322.6632138339933, 2325.093213646679, 2269.0810221860174, 2284.6001949658826, 2322.7212734471805, 2323.3959170615594, 2325.0699720112007, 2313.53729254149, 2314.432963923841, 2331.40549159964, 2333.7782910623464, 2337.824663150262, 2217.966730499044, 2225.7551669316445, 2234.1845226492214, 2234.597772400967, 2234.9776502235013, 2243.5512897420417, 2270.8637481750984, 2285.42864283929, 2288.656701494789, 2291.9541609167723, 8432.325413966868, 8478.915210847874, 8480.915190848074, 8498.957505212435, 8537.957310213409, 4994.325766021577, 5127.410347810012, 5143.614228932845, 5147.897042059138, 5155.7679904404395, 3303.405387030358, 3331.6335203127637, 3410.6077801052948, 3422.828858557087, 3442.6729460701195, 1158.5018442069907, 1162.6918866500384, 1163.0288708928056, 1183.4142099660723, 1214.089432925306, 11499.885001149965, 11518.136139789549, 11525.308481491054, 11533.365664888428, 11594.188406811527, 4235.131797981407, 4557.225271703752, 4565.360849481075, 4575.267957126844, 4690.437147542317, 9769.706908792748, 9782.804343913082, 9804.068613481708, 9859.654912078044, 9874.259430542594, 5127.282180494733, 5141.331626888481, 5159.17453207485, 5161.096808058574, 5189.974050129726, 4025.3961905714377, 4732.976335118371, 4733.053389322149, 4752.477227505041, 4775.06886157196, 3906.980465097713, 3918.2163567286657, 4057.0668746188544, 4058.2086493134148, 4063.329550624173, 1257.1451413039222, 1272.179444258448, 1283.595667364777, 1287.0925997171971, 1296.1704509114174, 965.9565319560637, 985.556499575194, 991.3605724307926, 994.8905620381752, 1023.9744006399751, 5973.611715238496, 5981.581289309794, 6001.969990150022, 6003.789867354709, 6152.938470615237, 455.6218338778806, 457.80543269110495, 459.0474764862923, 461.5661278398295, 461.7114303560275, 4017.6986725995084, 4235.449391579075, 4256.3189889617515, 4261.509926358446, 4275.422817919603, 9983.450910200008, 10437.0, 10585.04734573892, 10593.57625694979, 10614.681559553226, 9867.40795552269, 10355.896441035493, 10361.378317300987, 10508.054275115277, 10522.894771052344, 7345.338919497271, 7398.260173982559, 7455.142658594223, 7458.067741532309, 7469.514481558681, 5489.478499542537, 5607.074832652566, 5615.775368985195, 5672.404397538199, 5700.515456186271, 9113.134252246025, 9192.95403522978, 9208.447493150432, 9234.861477077715, 9329.626814927327, 9301.348905576544, 9320.067993200626, 9551.14039736427, 9622.085901839315, 9698.466584337646, 7129.572225666477, 7265.418766498562, 7320.670569824264, 7350.08123984502, 7508.249175082448, 7882.566458844819, 7885.763427097197, 7926.405519586169, 7929.167437418988, 7930.762077137695, 7060.7881763547175, 7147.606881621561, 7247.8550428990075, 7261.5280006799385, 7351.301626345488, 7221.4222862169845, 7262.455315851226, 7325.047743793486, 7380.77857664271, 7448.851022979402, 6715.0, 6792.422644075309, 6828.248892621907, 6874.072000279898, 6875.724971001304, 5015.498450154955, 5027.899442011212, 5057.69653820772, 5100.285959965682, 5166.922496162636, 5014.34813474246, 5039.496050394931, 5100.6429549931145, 5199.090159222196, 5232.215167724872], "value": 4430.884870590494, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.9676032396759, 332.7190317278477, 337.8142021887961, 338.84074484992044, 342.0627480702874, 5954.970225148868, 5962.34414214436, 6074.483668888144, 6205.23150901993, 6212.844678883031, 5998.670073145975, 6022.8795424091495, 6040.758369665219, 6049.274087109542, 6065.878682426349, 4632.351470794091, 4666.183417901871, 4672.462666793328, 4673.462551806535, 4678.4619768726525, 4435.9334609980715, 4666.556677115668, 4693.577578017977, 4696.976515117437, 4712.222483290253, 4586.4266966629175, 4588.449386073659, 4608.308753686941, 4632.837850675227, 4647.790849411767, 4609.262517997138, 4627.167109920213, 4627.444706635225, 4646.25659894417, 4652.860414187579, 4004.759714417144, 4064.715469917107, 4081.6326530612387, 4082.7346222495444, 4105.630493255621, 5790.739416726257, 5845.181674565564, 5846.9707651461895, 5850.210221620069, 5862.794802181946, 5336.599755018389, 5342.332208473941, 5348.839534813962, 5349.277847490578, 5362.812301569426, 6164.6917654117115, 6363.96818015907, 6375.968120159369, 6389.36106389362, 6395.3284905084765, 4476.7761611919595, 4491.0, 4494.1910456117885, 4499.145162419162, 4538.546145385468, 6441.613503189777, 6635.900461493082, 6667.699953502104, 6687.0, 6708.798736037927, 4534.0, 4579.977100114478, 4594.448666160082, 4598.057398233354, 4609.8847528811375, 4648.6745927785405, 4656.208444564432, 4667.789949452215, 4673.789679464432, 4678.0410015946645, 5191.169412893919, 5320.680759154463, 5322.946770532322, 5340.092184328673, 5347.893042139135, 6039.4262545058145, 6232.3144454110015, 6389.936100639027, 6402.727031903607, 6448.032795080775, 1617.5875151836206, 1628.2510045379022, 1631.4126914310839, 1634.4197809777595, 1637.2386840119402, 1069.9518521666544, 1094.409019129677, 1097.3306283167262, 1102.8676558812833, 1117.6423544465856, 6089.543284253698, 6100.938990610126, 6120.908186377208, 6134.294556126102, 6184.8763024739255, 6497.545171837926, 6542.509311801538, 6594.7032383542855, 6607.108040414579, 6659.700313485905, 6003.909941350883, 6197.752089916353, 6244.937550624527, 6254.593451425642, 6257.843553911189, 3550.343186510504, 3558.5373901393173, 3565.982170089133, 3571.39286321326, 3573.446115852047, 6586.868262634816, 6798.082258894986, 6833.282505336968, 6843.452523798084, 6887.655617219119, 6732.865342693119, 6740.573393578308, 6768.153980752406, 6773.288804675537, 6790.151231096113, 6625.403713665697, 6856.965715171492, 6863.416609588241, 6866.759663411756, 6869.828254293682, 6408.871822563616, 6497.220333560003, 6562.77030303937, 6579.572327798678, 6607.456129390123, 6298.984325016134, 6363.5863668861375, 6431.774887878902, 6439.388258115471, 6499.5125365598715, 6781.47416831209, 6786.830329241809, 6805.149356330458, 6825.215100263533, 6853.554518956252, 4603.516630753723, 4607.424071991001, 4615.515370886009, 4630.6758526902795, 4635.814567417266, 6477.578957367756, 6485.643289618927, 6576.605403675603, 6579.539432239697, 6755.324467553205, 6440.645764482999, 6489.286178520265, 6511.218653761579, 6524.445422139172, 6539.280679125197, 6330.936690633035, 6427.6786160690845, 6435.163428754232, 6455.838604034937, 6486.416222539994, 6321.008882202092, 6361.904571431525, 6371.426571608577, 6377.553571249968, 6390.137331460193, 6478.287388387368, 6479.773207937699, 6480.773172938924, 6544.640044797582, 6562.606243625398, 6185.226846644169, 6272.874542509216, 6404.391582799627, 6415.133956915944, 6422.357764223727], "value": 4843.381756182632, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.3777607921305, 779.8518281526506, 816.3020617372146, 827.2554700769309, 843.7384410832642, 14469.276536173189, 14602.926985365084, 14730.63173420665, 14740.852591474082, 14772.335244913991, 12321.137520373577, 13512.662183445418, 13546.0, 13594.0, 13601.795973060413, 765.2577000309691, 803.8111043904678, 804.1235053791366, 805.1545876829335, 805.5810978291285, 796.5300472721093, 800.7357572001225, 802.626778547975, 802.7591722483261, 804.8953636027309, 836.113719457374, 837.4933165434885, 838.7861095420659, 838.7903024243939, 839.7858546070744, 823.2878560045577, 830.4933990265932, 833.1335411172373, 834.7954751085962, 835.381817455085, 606.8240210338996, 607.1803065861096, 610.0940103945637, 612.3417326374166, 612.583443258584, 12719.0, 12735.617931462071, 12742.872571274262, 12758.936205318914, 12790.0, 13625.18248905059, 13813.102148360324, 13837.930810345884, 13857.514986975508, 13958.93020534901, 12260.754784904251, 12315.261084334968, 12371.319577423239, 12479.50081996719, 12531.06017048725, 4606.424196975378, 4608.5621865922685, 4641.559051890065, 4748.572628463455, 4764.904701905977, 57104.428955710326, 57830.42169578293, 58033.41966580322, 59272.70363648154, 59666.70166649139, 11305.265157764883, 11453.59912403062, 11472.54109835614, 11477.139214558942, 11498.0, 20269.797302027087, 20325.390238292875, 20426.897865510873, 20457.48856278605, 20775.168993240102, 8384.748457546284, 8462.746117616482, 8494.53280069602, 8511.574421279036, 8545.230929216275, 4501.707389019703, 4621.12198682256, 4682.204025315705, 4705.4588722296685, 4782.856514304576, 3250.593675790526, 3340.9643010666773, 3342.097633638904, 3344.1973926257524, 3346.966530334714, 637.445422482434, 651.46905272203, 654.5352799512305, 654.6922946215367, 655.8917778566579, 613.5214532664529, 632.7923074637818, 682.1507223506766, 693.389816961071, 701.9859602808017, 8961.538652981792, 9158.771030724285, 9169.495677737788, 9235.1688348049, 9434.433933963985, 597.4682532546037, 616.2266355723627, 619.3187493756922, 644.291279592454, 687.1376422589718, 4124.257633625976, 4149.5382782245815, 4188.183304255702, 4282.657387409, 4295.22685916538, 57516.42483575111, 57544.136837947466, 58009.70995144997, 58078.41921580815, 60107.39892601018, 52124.739376302874, 56262.718686406304, 57993.71003145041, 59095.70452147712, 59155.40844591499, 53150.46849531533, 53153.7342313286, 53779.999999999214, 54240.45759542354, 54427.72786136044, 8856.601452934505, 9085.772855678397, 9133.132352426508, 9184.448933064037, 9313.674021409219, 34649.48025779565, 34664.480032800035, 34854.12864678302, 35031.82484087563, 35122.297554049284, 39991.40012899867, 41267.38098928578, 44825.77587112174, 45204.321935171654, 45714.0, 12280.631581052583, 12358.50565977351, 12493.125481216592, 12515.436805343963, 12695.36523173856, 13298.534551290659, 13719.1082579636, 13795.034347595572, 13925.164490130624, 14177.858221417653, 13271.137376070525, 13331.866681333451, 13617.591472255848, 13771.242581658105, 13966.371513281723, 12933.0, 12966.546170883974, 13226.735465290449, 13687.247201404018, 13725.725485490433, 12988.67528311762, 13338.666533336744, 13526.526571569948, 13606.659833504242, 13733.862661373258, 10140.087392134743, 10173.13528350069, 10361.326513776581, 10597.046265836112, 10685.305455145392, 10738.463076846283, 11086.501107450345, 11164.609238676607, 11345.432728363383, 11468.4265786712], "value": 6810.877528300034, "unit": "score"}], "name": "dromaeo_css", "value": 7112.308746394352, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 112.0, 113.0, 109.0, 124.0, 111.0, 111.0, 110.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 134.0, 164.0, 184.0, 128.0, 156.0, 158.0, 129.0, 184.0, 138.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 162.0, 163.0, 164.0, 175.0, 162.0, 164.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 171.0, 75.0, 74.0, 77.0, 73.0, 164.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 157.0, 93.0, 92.0, 93.0, 144.0, 92.0, 93.0, 144.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 151.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 94.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 56.0, 58.0, 58.0, 56.0, 57.0, 69.0, 55.0, 54.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 62.0, 61.0, 60.0, 60.0, 61.0, 61.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 77.0, 77.0, 77.0, 78.0, 79.0, 80.0, 81.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 138.0, 132.0, 139.0, 127.0, 128.0, 127.0, 158.0, 129.0], "value": 133.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 171.0, 170.0, 167.0, 182.0, 168.0, 168.0, 176.0, 174.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 69.0, 68.0, 70.0, 69.0, 68.0, 68.0, 67.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1565.5, "alertThreshold": 2.0}]} 06:10:49 INFO - Return code: 0 06:10:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:10:49 ERROR - # TBPL SUCCESS # 06:10:49 INFO - Running post-action listener: _resource_record_post_action 06:10:49 INFO - Running post-run listener: _resource_record_post_run 06:10:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 534462464; Read time: 0; Write time: 480012 06:10:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244133888; Read time: 0; Write time: 261500 06:10:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 290328576; Read time: 0; Write time: 218512 06:10:50 INFO - Running post-run listener: _upload_blobber_files 06:10:50 INFO - Blob upload gear active. 06:10:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:10:50 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 06:10:50 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'] 06:10:50 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 06:10:50 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:10:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:10:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:51 INFO - (blobuploader) - INFO - Done attempting. 06:10:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:10:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:10:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:52 INFO - (blobuploader) - INFO - Done attempting. 06:10:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:52 INFO - Return code: 0 06:10:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f15f3e8e07d7beef3d4d31614e4edbeb0751bd83f8d8191ba7368f3a57ec10501b4def897a5c8c28888e6b81866b00e185f358607a32bf7f88780a92a257ca6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8cdc239ccdf3e98a76ed7a6f66fc812d80691a7a0f643a6b6f6434ff1af9259645743b4b719caa668ff3e3d49171444fb40a4500e88c3dde4347d860c1b0a8"} 06:10:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:52 INFO - Contents: 06:10:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f15f3e8e07d7beef3d4d31614e4edbeb0751bd83f8d8191ba7368f3a57ec10501b4def897a5c8c28888e6b81866b00e185f358607a32bf7f88780a92a257ca6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8cdc239ccdf3e98a76ed7a6f66fc812d80691a7a0f643a6b6f6434ff1af9259645743b4b719caa668ff3e3d49171444fb40a4500e88c3dde4347d860c1b0a8"} 06:10:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:52 INFO - Copying logs to upload dir... 06:10:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.825578 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-19 06:10:51.982668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 06:10:51.986546) ========= 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=4300f881736b422476174874000001bc-1461067770.605346-1744972455 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/6f15f3e8e07d7beef3d4d31614e4edbeb0751bd83f8d8191ba7368f3a57ec10501b4def897a5c8c28888e6b81866b00e185f358607a32bf7f88780a92a257ca6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8cdc239ccdf3e98a76ed7a6f66fc812d80691a7a0f643a6b6f6434ff1af9259645743b4b719caa668ff3e3d49171444fb40a4500e88c3dde4347d860c1b0a8"} build_url:https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/UeKkVY9dSnGz8FVa-K5FDA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f15f3e8e07d7beef3d4d31614e4edbeb0751bd83f8d8191ba7368f3a57ec10501b4def897a5c8c28888e6b81866b00e185f358607a32bf7f88780a92a257ca6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8cdc239ccdf3e98a76ed7a6f66fc812d80691a7a0f643a6b6f6434ff1af9259645743b4b719caa668ff3e3d49171444fb40a4500e88c3dde4347d860c1b0a8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 06:10:52.013583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:10:52.014090) ========= 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=4300f881736b422476174874000001bc-1461067770.605346-1744972455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 06:10:52.098488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 06:10:52.098900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 06:10:52.099246) ========= ========= Total master_lag: 0.18 =========